builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1456531136.01 results: success (0) buildid: 20160226133250 builduid: 5943cc503b4149e7b554d1712835fffe revision: c728ed2a0ba979418ce9ea98cfb45b55967cc7cb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.008148) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.008638) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.008965) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009106 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.039585) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.039983) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.099310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.099592) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.166899) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.167235) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.167897) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.168211) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-26 15:58:56-- 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.6M=0s 2016-02-26 15:58:56 (84.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146403 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.332111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.332429) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017299 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:56.391815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 15:58:56.392153) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c728ed2a0ba979418ce9ea98cfb45b55967cc7cb --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev c728ed2a0ba979418ce9ea98cfb45b55967cc7cb --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-26 15:58:56,538 truncating revision to first 12 chars 2016-02-26 15:58:56,538 Setting DEBUG logging. 2016-02-26 15:58:56,538 attempt 1/10 2016-02-26 15:58:56,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/c728ed2a0ba9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-26 15:58:57,793 unpacking tar archive at: mozilla-inbound-c728ed2a0ba9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.561300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-26 15:58:57.968193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:57.968578) ========= echo c728ed2a0ba979418ce9ea98cfb45b55967cc7cb in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c728ed2a0ba979418ce9ea98cfb45b55967cc7cb'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c728ed2a0ba979418ce9ea98cfb45b55967cc7cb program finished with exit code 0 elapsedTime=0.004705 script_repo_revision: 'c728ed2a0ba979418ce9ea98cfb45b55967cc7cb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:58.019338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:58.019678) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-26 15:58:58.029290) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-02-26 15:58:58.029591) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:58 INFO - MultiFileLogger online at 20160226 15:58:58 in /builds/slave/test-pgo 15:58:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:58:58 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:58:58 INFO - {'append_to_log': False, 15:58:58 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:58:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:58:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:58:58 INFO - 'branch': 'Mozilla-Inbound', 15:58:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:58 INFO - 'config_files': ('talos/linux_config.py',), 15:58:58 INFO - 'default_actions': ('clobber', 15:58:58 INFO - 'read-buildbot-config', 15:58:58 INFO - 'download-and-extract', 15:58:58 INFO - 'populate-webroot', 15:58:58 INFO - 'create-virtualenv', 15:58:58 INFO - 'install', 15:58:58 INFO - 'run-tests'), 15:58:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:58 INFO - 'download_minidump_stackwalk': True, 15:58:58 INFO - 'download_symbols': 'ondemand', 15:58:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:58 INFO - 'installer_path': 'installer.exe', 15:58:58 INFO - 'log_level': 'info', 15:58:58 INFO - 'log_name': 'talos', 15:58:58 INFO - 'log_to_console': True, 15:58:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:58 INFO - 'opt_config_files': (), 15:58:58 INFO - 'pip_index': False, 15:58:58 INFO - 'sps_profile': False, 15:58:58 INFO - 'sps_profile_interval': 0, 15:58:58 INFO - 'suite': 'dromaeojs-e10s', 15:58:58 INFO - 'system_bits': '32', 15:58:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:58 INFO - 'title': 'talos-linux64-ix-055', 15:58:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:58 INFO - 'use_talos_json': True, 15:58:58 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:58:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:58 INFO - 'work_dir': 'build'} 15:58:58 INFO - ##### 15:58:58 INFO - ##### Running clobber step. 15:58:58 INFO - ##### 15:58:58 INFO - Running pre-action listener: _resource_record_pre_action 15:58:58 INFO - Running main action method: clobber 15:58:58 INFO - rmtree: /builds/slave/test-pgo/build 15:58:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:58:59 INFO - Running post-action listener: _resource_record_post_action 15:58:59 INFO - ##### 15:58:59 INFO - ##### Running read-buildbot-config step. 15:58:59 INFO - ##### 15:58:59 INFO - Running pre-action listener: _resource_record_pre_action 15:58:59 INFO - Running main action method: read_buildbot_config 15:58:59 INFO - Using buildbot properties: 15:58:59 INFO - { 15:58:59 INFO - "project": "", 15:58:59 INFO - "product": "firefox", 15:58:59 INFO - "script_repo_revision": "production", 15:58:59 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:58:59 INFO - "repository": "", 15:58:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:58:59 INFO - "buildid": "20160226133250", 15:58:59 INFO - "pgo_build": "True", 15:58:59 INFO - "basedir": "/builds/slave/test-pgo", 15:58:59 INFO - "buildnumber": 716, 15:58:59 INFO - "slavename": "talos-linux64-ix-055", 15:58:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:58:59 INFO - "platform": "ubuntu64_hw", 15:58:59 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:58:59 INFO - "branch": "mozilla-inbound", 15:58:59 INFO - "repo_path": "integration/mozilla-inbound", 15:58:59 INFO - "revision": "c728ed2a0ba979418ce9ea98cfb45b55967cc7cb", 15:58:59 INFO - "stage_platform": "linux64-pgo", 15:58:59 INFO - "builduid": "5943cc503b4149e7b554d1712835fffe", 15:58:59 INFO - "slavebuilddir": "test" 15:58:59 INFO - } 15:58:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 15:58:59 INFO - Running post-action listener: _resource_record_post_action 15:58:59 INFO - ##### 15:58:59 INFO - ##### Running download-and-extract step. 15:58:59 INFO - ##### 15:58:59 INFO - Running pre-action listener: _resource_record_pre_action 15:58:59 INFO - Running main action method: download_and_extract 15:58:59 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:58: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')]} 15:58:59 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json 15:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json 15:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:59:06 INFO - Downloaded 1448 bytes. 15:59:06 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:59:06 INFO - Using the following test package requirements: 15:59:06 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:06 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:59:06 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:59:06 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'jsshell-linux-x86_64.zip'], 15:59:06 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:59:06 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:06 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:59:06 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:59:06 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:59:06 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:06 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:06 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:59:06 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:06 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:59:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:59:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:14 INFO - Downloaded 23370843 bytes. 15:59:14 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'] 15:59:14 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 15:59:15 INFO - Return code: 0 15:59:15 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 15:59:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:15 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:59:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 15:59:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:21 INFO - Downloaded 23370843 bytes. 15:59:21 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'] 15:59:21 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 15:59:22 INFO - Return code: 0 15:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:22 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:24 INFO - Downloaded 10713410 bytes. 15:59:24 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'] 15:59:24 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 15:59:24 INFO - Return code: 0 15:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:24 INFO - https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VZ3WgruzQ4SdmSYV13xy5g/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 15:59:25 INFO - Downloaded 56629920 bytes. 15:59:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:25 INFO - mkdir: /builds/slave/test-pgo/properties 15:59:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:59:25 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:59:25 INFO - Contents: 15:59:25 INFO - build_url:https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 15:59:26 INFO - Running post-action listener: _resource_record_post_action 15:59:26 INFO - Running post-action listener: set_extra_try_arguments 15:59:26 INFO - ##### 15:59:26 INFO - ##### Running populate-webroot step. 15:59:26 INFO - ##### 15:59:26 INFO - Running pre-action listener: _resource_record_pre_action 15:59:26 INFO - Running main action method: populate_webroot 15:59:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:26 INFO - '--tppagecycles', 15:59:26 INFO - '7'], 15:59:26 INFO - 'tests': ['tsvgm']}}, 15:59:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:59:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:59:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'tests': ['damp', 'tps']}, 15:59:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['damp', 'tps']}, 15:59:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:59:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:26 INFO - 'other': {'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore']}, 15:59:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore']}, 15:59:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore']}, 15:59:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore']}, 15:59:26 INFO - 'other_l64': {'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore']}, 15:59:26 INFO - 'other_nol64': {'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore']}, 15:59:26 INFO - 'svgr': {'tests': ['tsvgx', 15:59:26 INFO - 'tsvgr_opacity', 15:59:26 INFO - 'tart', 15:59:26 INFO - 'tscrollx', 15:59:26 INFO - 'cart']}, 15:59:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['tsvgx', 15:59:26 INFO - 'tsvgr_opacity', 15:59:26 INFO - 'tart', 15:59:26 INFO - 'tscrollx', 15:59:26 INFO - 'cart']}, 15:59:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'tests': ['tp5o']}, 15:59:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--e10s'], 15:59:26 INFO - 'tests': ['tp5o']}, 15:59:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--xperf_path', 15:59:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:26 INFO - 'tests': ['tp5n']}, 15:59:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--e10s', 15:59:26 INFO - '--xperf_path', 15:59:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:26 INFO - 'tests': ['tp5n']}}, 15:59:26 INFO - 'talos.zip': {'path': '', 15:59:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:26 INFO - Running post-action listener: _resource_record_post_action 15:59:26 INFO - ##### 15:59:26 INFO - ##### Running create-virtualenv step. 15:59:26 INFO - ##### 15:59:26 INFO - Running pre-action listener: _resource_record_pre_action 15:59:26 INFO - Running main action method: create_virtualenv 15:59:26 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:59:26 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 15:59:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:59:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:26 INFO - Using real prefix '/usr' 15:59:26 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:59:26 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:28 INFO - Installing pip.................done. 15:59:28 INFO - Return code: 0 15:59:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:59:28 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')]} 15:59:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:28 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')]} 15:59:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:28 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 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:28 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 15:59:28 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 15:59:28 INFO - Using env: {'DISPLAY': ':0', 15:59:28 INFO - 'HOME': '/home/cltbld', 15:59:28 INFO - 'LANG': 'en_US.UTF-8', 15:59:28 INFO - 'LANGUAGE': 'en_US:en', 15:59:28 INFO - 'LOGNAME': 'cltbld', 15:59:28 INFO - 'MAIL': '/var/mail/cltbld', 15:59:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:28 INFO - 'MOZ_NO_REMOTE': '1', 15:59:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:28 INFO - 'NO_EM_RESTART': '1', 15:59:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:28 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:28 INFO - 'SHELL': '/bin/bash', 15:59:28 INFO - 'SHLVL': '1', 15:59:28 INFO - 'TERM': 'linux', 15:59:28 INFO - 'TMOUT': '86400', 15:59:28 INFO - 'USER': 'cltbld', 15:59:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:28 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:59:29 INFO - Cleaning up... 15:59:29 INFO - Return code: 0 15:59:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:59:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:29 INFO - Downloading/unpacking psutil>=0.7.1 15:59:29 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 15:59:29 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 15:59:29 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 15:59:29 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 15:59:29 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 15:59:29 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 15:59:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:31 INFO - Installing collected packages: psutil 15:59:31 INFO - Running setup.py install for psutil 15:59:31 INFO - building 'psutil._psutil_linux' extension 15:59:31 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 15:59:31 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 15:59:31 INFO - building 'psutil._psutil_posix' extension 15:59:31 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 15:59:31 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 15:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:31 INFO - Successfully installed psutil 15:59:31 INFO - Cleaning up... 15:59:31 INFO - Return code: 0 15:59:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:59:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:59:31 INFO - Using env: {'DISPLAY': ':0', 15:59:31 INFO - 'HOME': '/home/cltbld', 15:59:31 INFO - 'LANG': 'en_US.UTF-8', 15:59:31 INFO - 'LANGUAGE': 'en_US:en', 15:59:31 INFO - 'LOGNAME': 'cltbld', 15:59:31 INFO - 'MAIL': '/var/mail/cltbld', 15:59:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:31 INFO - 'MOZ_NO_REMOTE': '1', 15:59:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:31 INFO - 'NO_EM_RESTART': '1', 15:59:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:31 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:31 INFO - 'SHELL': '/bin/bash', 15:59:31 INFO - 'SHLVL': '1', 15:59:31 INFO - 'TERM': 'linux', 15:59:31 INFO - 'TMOUT': '86400', 15:59:31 INFO - 'USER': 'cltbld', 15:59:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:31 INFO - '_': '/tools/buildbot/bin/python'} 15:59:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:59:31 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 15:59:31 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 15:59:31 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 15:59:31 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 15:59:31 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 15:59:31 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 15:59:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:33 INFO - Installing collected packages: mozsystemmonitor 15:59:33 INFO - Running setup.py install for mozsystemmonitor 15:59:33 INFO - Successfully installed mozsystemmonitor 15:59:33 INFO - Cleaning up... 15:59:34 INFO - Return code: 0 15:59:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:59:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:59:34 INFO - Using env: {'DISPLAY': ':0', 15:59:34 INFO - 'HOME': '/home/cltbld', 15:59:34 INFO - 'LANG': 'en_US.UTF-8', 15:59:34 INFO - 'LANGUAGE': 'en_US:en', 15:59:34 INFO - 'LOGNAME': 'cltbld', 15:59:34 INFO - 'MAIL': '/var/mail/cltbld', 15:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:34 INFO - 'MOZ_NO_REMOTE': '1', 15:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:34 INFO - 'NO_EM_RESTART': '1', 15:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:34 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:34 INFO - 'SHELL': '/bin/bash', 15:59:34 INFO - 'SHLVL': '1', 15:59:34 INFO - 'TERM': 'linux', 15:59:34 INFO - 'TMOUT': '86400', 15:59:34 INFO - 'USER': 'cltbld', 15:59:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:34 INFO - '_': '/tools/buildbot/bin/python'} 15:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:34 INFO - Downloading/unpacking blobuploader==1.2.4 15:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:59:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - Downloading docopt-0.6.1.tar.gz 15:59:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:36 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:36 INFO - Running setup.py install for blobuploader 15:59:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:36 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:59:36 INFO - Running setup.py install for requests 15:59:37 INFO - Running setup.py install for docopt 15:59:37 INFO - Successfully installed blobuploader requests docopt 15:59:37 INFO - Cleaning up... 15:59:37 INFO - Return code: 0 15:59:37 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:37 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 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:37 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 15:59:37 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 15:59:37 INFO - Using env: {'DISPLAY': ':0', 15:59:37 INFO - 'HOME': '/home/cltbld', 15:59:37 INFO - 'LANG': 'en_US.UTF-8', 15:59:37 INFO - 'LANGUAGE': 'en_US:en', 15:59:37 INFO - 'LOGNAME': 'cltbld', 15:59:37 INFO - 'MAIL': '/var/mail/cltbld', 15:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:37 INFO - 'MOZ_NO_REMOTE': '1', 15:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:37 INFO - 'NO_EM_RESTART': '1', 15:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:37 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:37 INFO - 'SHELL': '/bin/bash', 15:59:37 INFO - 'SHLVL': '1', 15:59:37 INFO - 'TERM': 'linux', 15:59:37 INFO - 'TMOUT': '86400', 15:59:37 INFO - 'USER': 'cltbld', 15:59:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:37 INFO - '_': '/tools/buildbot/bin/python'} 15:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:37 INFO - Running setup.py (path:/tmp/pip-XwjY4J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:37 INFO - Running setup.py (path:/tmp/pip-yi0NBK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:37 INFO - Running setup.py (path:/tmp/pip-4JxeJ9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:37 INFO - Running setup.py (path:/tmp/pip-T63J8n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:37 INFO - Running setup.py (path:/tmp/pip-5Lvi31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:37 INFO - Running setup.py (path:/tmp/pip-3KWsya-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:38 INFO - Running setup.py (path:/tmp/pip-ylCyTJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:38 INFO - Running setup.py (path:/tmp/pip-4pTjxf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:38 INFO - Running setup.py (path:/tmp/pip-6yH7zy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:38 INFO - Running setup.py (path:/tmp/pip-tWTojv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:38 INFO - Running setup.py (path:/tmp/pip-JlGH17-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:38 INFO - Running setup.py (path:/tmp/pip-nWkQ92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:38 INFO - Running setup.py (path:/tmp/pip-RKVvcV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:38 INFO - Running setup.py (path:/tmp/pip-X6Ah1q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:38 INFO - Running setup.py (path:/tmp/pip-A9Jvt8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:38 INFO - Running setup.py (path:/tmp/pip-6YIZzo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:38 INFO - Running setup.py (path:/tmp/pip-5F6d7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:38 INFO - Running setup.py install for manifestparser 15:59:38 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:59:38 INFO - Running setup.py install for mozcrash 15:59:39 INFO - Running setup.py install for mozdebug 15:59:39 INFO - Running setup.py install for mozdevice 15:59:39 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Running setup.py install for mozfile 15:59:39 INFO - Running setup.py install for mozhttpd 15:59:39 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Running setup.py install for mozinfo 15:59:39 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Running setup.py install for mozInstall 15:59:39 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Running setup.py install for mozleak 15:59:39 INFO - Running setup.py install for mozlog 15:59:39 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Running setup.py install for moznetwork 15:59:39 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:59:39 INFO - Running setup.py install for mozprocess 15:59:40 INFO - Running setup.py install for mozprofile 15:59:40 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:59:40 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:59:40 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:59:40 INFO - Running setup.py install for mozrunner 15:59:40 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:59:40 INFO - Running setup.py install for mozscreenshot 15:59:40 INFO - Running setup.py install for moztest 15:59:40 INFO - Running setup.py install for mozversion 15:59:40 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:59:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:40 INFO - Cleaning up... 15:59:40 INFO - Return code: 0 15:59:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:40 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 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:40 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 15:59:40 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 15:59:40 INFO - Using env: {'DISPLAY': ':0', 15:59:40 INFO - 'HOME': '/home/cltbld', 15:59:40 INFO - 'LANG': 'en_US.UTF-8', 15:59:40 INFO - 'LANGUAGE': 'en_US:en', 15:59:40 INFO - 'LOGNAME': 'cltbld', 15:59:40 INFO - 'MAIL': '/var/mail/cltbld', 15:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:40 INFO - 'MOZ_NO_REMOTE': '1', 15:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:40 INFO - 'NO_EM_RESTART': '1', 15:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:40 INFO - 'SHELL': '/bin/bash', 15:59:40 INFO - 'SHLVL': '1', 15:59:40 INFO - 'TERM': 'linux', 15:59:40 INFO - 'TMOUT': '86400', 15:59:40 INFO - 'USER': 'cltbld', 15:59:40 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:40 INFO - '_': '/tools/buildbot/bin/python'} 15:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:40 INFO - Running setup.py (path:/tmp/pip-MdvCtu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:59:40 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)) 15:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:40 INFO - Running setup.py (path:/tmp/pip-BHzZDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:59:40 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)) 15:59:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:40 INFO - Running setup.py (path:/tmp/pip-Dx0yn5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:41 INFO - Running setup.py (path:/tmp/pip-YtgWkd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:41 INFO - Running setup.py (path:/tmp/pip-tXC2ja-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:41 INFO - Running setup.py (path:/tmp/pip-uWI1Bc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:41 INFO - Running setup.py (path:/tmp/pip-v1CbLU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:41 INFO - Running setup.py (path:/tmp/pip-cJOkW_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:41 INFO - Running setup.py (path:/tmp/pip-Mjjs5v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:41 INFO - Running setup.py (path:/tmp/pip-A4qITf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:41 INFO - Running setup.py (path:/tmp/pip-8VLcEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:41 INFO - Running setup.py (path:/tmp/pip-Eq3saI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:41 INFO - Running setup.py (path:/tmp/pip-MzQ5HN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:41 INFO - Running setup.py (path:/tmp/pip-w53Dom-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:41 INFO - Running setup.py (path:/tmp/pip-FAq_j0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:41 INFO - Running setup.py (path:/tmp/pip-SFhnJn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:59:41 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)) 15:59:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:41 INFO - Running setup.py (path:/tmp/pip-HMav31-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:59:42 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)) 15:59:42 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)) 15:59:42 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)) 15:59:42 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)) 15:59:42 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)) 15:59:42 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)) 15:59:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:42 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 15:59:43 INFO - Downloading blessings-1.6.tar.gz 15:59:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:43 INFO - Installing collected packages: blessings 15:59:43 INFO - Running setup.py install for blessings 15:59:44 INFO - Successfully installed blessings 15:59:44 INFO - Cleaning up... 15:59:44 INFO - Return code: 0 15:59:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:59:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:59:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:59:44 INFO - Reading from file tmpfile_stdout 15:59:44 INFO - Current package versions: 15:59:44 INFO - argparse == 1.2.1 15:59:44 INFO - blessings == 1.6 15:59:44 INFO - blobuploader == 1.2.4 15:59:44 INFO - docopt == 0.6.1 15:59:44 INFO - manifestparser == 1.1 15:59:44 INFO - mozInstall == 1.12 15:59:44 INFO - mozcrash == 0.16 15:59:44 INFO - mozdebug == 0.1 15:59:44 INFO - mozdevice == 0.48 15:59:44 INFO - mozfile == 1.2 15:59:44 INFO - mozhttpd == 0.7 15:59:44 INFO - mozinfo == 0.9 15:59:44 INFO - mozleak == 0.1 15:59:44 INFO - mozlog == 3.1 15:59:44 INFO - moznetwork == 0.27 15:59:44 INFO - mozprocess == 0.22 15:59:44 INFO - mozprofile == 0.28 15:59:44 INFO - mozrunner == 6.11 15:59:44 INFO - mozscreenshot == 0.1 15:59:44 INFO - mozsystemmonitor == 0.0 15:59:44 INFO - moztest == 0.7 15:59:44 INFO - mozversion == 1.4 15:59:44 INFO - psutil == 3.1.1 15:59:44 INFO - requests == 1.2.3 15:59:44 INFO - wsgiref == 0.1.2 15:59:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59:44 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 15:59:44 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 15:59:44 INFO - Using env: {'DISPLAY': ':0', 15:59:44 INFO - 'HOME': '/home/cltbld', 15:59:44 INFO - 'LANG': 'en_US.UTF-8', 15:59:44 INFO - 'LANGUAGE': 'en_US:en', 15:59:44 INFO - 'LOGNAME': 'cltbld', 15:59:44 INFO - 'MAIL': '/var/mail/cltbld', 15:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:44 INFO - 'MOZ_NO_REMOTE': '1', 15:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:44 INFO - 'NO_EM_RESTART': '1', 15:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:44 INFO - 'SHELL': '/bin/bash', 15:59:44 INFO - 'SHLVL': '1', 15:59:44 INFO - 'TERM': 'linux', 15:59:44 INFO - 'TMOUT': '86400', 15:59:44 INFO - 'USER': 'cltbld', 15:59:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:44 INFO - '_': '/tools/buildbot/bin/python'} 15:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 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)) 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:59:44 INFO - Cleaning up... 15:59:44 INFO - Return code: 0 15:59:44 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59: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', 'jsonschema'] in /builds/slave/test-pgo/build 15:59: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 jsonschema 15:59:44 INFO - Using env: {'DISPLAY': ':0', 15:59:44 INFO - 'HOME': '/home/cltbld', 15:59:44 INFO - 'LANG': 'en_US.UTF-8', 15:59:44 INFO - 'LANGUAGE': 'en_US:en', 15:59:44 INFO - 'LOGNAME': 'cltbld', 15:59:44 INFO - 'MAIL': '/var/mail/cltbld', 15:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:44 INFO - 'MOZ_NO_REMOTE': '1', 15:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:44 INFO - 'NO_EM_RESTART': '1', 15:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:44 INFO - 'SHELL': '/bin/bash', 15:59:44 INFO - 'SHLVL': '1', 15:59:44 INFO - 'TERM': 'linux', 15:59:44 INFO - 'TMOUT': '86400', 15:59:44 INFO - 'USER': 'cltbld', 15:59:44 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:44 INFO - '_': '/tools/buildbot/bin/python'} 15:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:44 INFO - Downloading/unpacking jsonschema 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:46 INFO - Downloading/unpacking functools32 (from jsonschema) 15:59:46 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 15:59:46 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 15:59:46 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 15:59:46 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 15:59:46 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 15:59:46 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 15:59:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:46 INFO - warning: no files found matching '*.txt' 15:59:46 INFO - no previously-included directories found matching 'build' 15:59:46 INFO - no previously-included directories found matching 'dist' 15:59:46 INFO - no previously-included directories found matching '.git*' 15:59:46 INFO - Installing collected packages: jsonschema, functools32 15:59:46 INFO - Running setup.py install for functools32 15:59:46 INFO - warning: no files found matching '*.txt' 15:59:46 INFO - no previously-included directories found matching 'build' 15:59:46 INFO - no previously-included directories found matching 'dist' 15:59:46 INFO - no previously-included directories found matching '.git*' 15:59:46 INFO - Successfully installed jsonschema functools32 15:59:46 INFO - Cleaning up... 15:59:47 INFO - Return code: 0 15:59:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:59: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')]} 15:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f038f315f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x136c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1439670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', '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 15:59: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', 'flake8'] in /builds/slave/test-pgo/build 15:59: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 flake8 15:59:47 INFO - Using env: {'DISPLAY': ':0', 15:59:47 INFO - 'HOME': '/home/cltbld', 15:59:47 INFO - 'LANG': 'en_US.UTF-8', 15:59:47 INFO - 'LANGUAGE': 'en_US:en', 15:59:47 INFO - 'LOGNAME': 'cltbld', 15:59:47 INFO - 'MAIL': '/var/mail/cltbld', 15:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:47 INFO - 'MOZ_NO_REMOTE': '1', 15:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:47 INFO - 'NO_EM_RESTART': '1', 15:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:59:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:59:47 INFO - 'SHELL': '/bin/bash', 15:59:47 INFO - 'SHLVL': '1', 15:59:47 INFO - 'TERM': 'linux', 15:59:47 INFO - 'TMOUT': '86400', 15:59:47 INFO - 'USER': 'cltbld', 15:59:47 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 15:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:47 INFO - '_': '/tools/buildbot/bin/python'} 15:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:47 INFO - Downloading/unpacking flake8 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:59:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:59:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:59:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:49 INFO - no previously-included directories found matching 'docs/_build' 15:59:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:59:49 INFO - Running setup.py install for pep8 15:59:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:59:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:59:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:59:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:59:49 INFO - no previously-included directories found matching 'docs/_build' 15:59:49 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:59:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:59:49 INFO - Cleaning up... 15:59:50 INFO - Return code: 0 15:59:50 INFO - Running post-action listener: _resource_record_post_action 15:59:50 INFO - Running post-action listener: _start_resource_monitoring 15:59:50 INFO - Starting resource monitoring. 15:59:50 INFO - ##### 15:59:50 INFO - ##### Running install step. 15:59:50 INFO - ##### 15:59:50 INFO - Running pre-action listener: _resource_record_pre_action 15:59:50 INFO - Running main action method: install 15:59:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:59:50 INFO - Reading from file tmpfile_stdout 15:59:50 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:59:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:59:50 INFO - Reading from file tmpfile_stdout 15:59:50 INFO - Output received: 15:59:50 INFO - Usage: mozinstall [options] installer 15:59:50 INFO - Options: 15:59:50 INFO - -h, --help show this help message and exit 15:59:50 INFO - -d DEST, --destination=DEST 15:59:50 INFO - Directory to install application into. [default: 15:59:50 INFO - "/builds/slave/test-pgo"] 15:59:50 INFO - --app=APP Application being installed. [default: firefox] 15:59:50 INFO - mkdir: /builds/slave/test-pgo/build/application 15:59:50 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'] 15:59:50 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 16:00:06 INFO - Reading from file tmpfile_stdout 16:00:06 INFO - Output received: 16:00:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 16:00:06 INFO - Running post-action listener: _resource_record_post_action 16:00:06 INFO - ##### 16:00:06 INFO - ##### Running run-tests step. 16:00:06 INFO - ##### 16:00:06 INFO - Running pre-action listener: _resource_record_pre_action 16:00:06 INFO - Running main action method: run_tests 16:00:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 16:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 16:00:06 INFO - Python 2.7.3 16:00:06 INFO - Return code: 0 16:00:06 INFO - grabbing minidump binary from tooltool 16:00:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c88c0>, '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 0x14c97c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c9c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 16:00:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 16:00:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:00:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:06 INFO - Return code: 0 16:00:06 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 16:00:06 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 16:00:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 16:00:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 16:00:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 16:00:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 16:00:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 16:00:07 INFO - Return code: 0 16:00:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 16:00:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:00:07 INFO - Using env: {'DISPLAY': ':0', 16:00:07 INFO - 'HOME': '/home/cltbld', 16:00:07 INFO - 'LANG': 'en_US.UTF-8', 16:00:07 INFO - 'LANGUAGE': 'en_US:en', 16:00:07 INFO - 'LOGNAME': 'cltbld', 16:00:07 INFO - 'MAIL': '/var/mail/cltbld', 16:00:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:00:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 16:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:07 INFO - 'MOZ_NO_REMOTE': '1', 16:00:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 16:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:07 INFO - 'NO_EM_RESTART': '1', 16:00:07 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 16:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 16:00:07 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 16:00:07 INFO - 'SHELL': '/bin/bash', 16:00:07 INFO - 'SHLVL': '1', 16:00:07 INFO - 'TERM': 'linux', 16:00:07 INFO - 'TMOUT': '86400', 16:00:07 INFO - 'USER': 'cltbld', 16:00:07 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222', 16:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:07 INFO - '_': '/tools/buildbot/bin/python'} 16:00:07 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:00:07 INFO - mozversion application_buildid: 20160226133250 16:00:07 INFO - mozversion application_changeset: c728ed2a0ba979418ce9ea98cfb45b55967cc7cb 16:00:07 INFO - mozversion application_display_name: Nightly 16:00:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:07 INFO - mozversion application_name: Firefox 16:00:07 INFO - mozversion application_remotingname: firefox 16:00:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:00:07 INFO - mozversion application_vendor: Mozilla 16:00:07 INFO - mozversion application_version: 47.0a1 16:00:07 INFO - mozversion platform_buildid: 20160226133250 16:00:07 INFO - mozversion platform_changeset: c728ed2a0ba979418ce9ea98cfb45b55967cc7cb 16:00:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:00:07 INFO - mozversion platform_version: 47.0a1 16:00:07 INFO - using testdate: 1456531207 16:00:07 INFO - actual date: 1456531207 16:00:08 INFO - starting webserver on 'localhost:60727' 16:00:08 INFO - SUITE-START | Running 2 tests 16:00:08 INFO - TEST-START | dromaeo_css 16:00:08 INFO - operating with platform_type : linux_ 16:00:08 INFO - Initialising browser for dromaeo_css test... 16:00:08 INFO - TEST-INFO | started process 28942 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpctOXjL/profile http://localhost:60727/getInfo.html) 16:00:11 INFO - PROCESS | 28942 | 16:00:11 INFO - PROCESS | 28942 | (process:29023): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:00:12 INFO - PROCESS | 28942 | __metrics Screen width/height:1600/1200 16:00:12 INFO - PROCESS | 28942 | colorDepth:24 16:00:12 INFO - PROCESS | 28942 | Browser inner width/height: 1024/697 16:00:12 INFO - PROCESS | 28942 | __metrics 16:00:12 ERROR - PROCESS | 28942 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:12 INFO - PROCESS | 28942 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:00:13 INFO - TEST-INFO | 28942: exit 0 16:00:13 INFO - Browser initialized. 16:00:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:13 INFO - TEST-INFO | started process 29074 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpctOXjL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:15 INFO - PROCESS | 29074 | 16:00:15 INFO - PROCESS | 29074 | (process:29134): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:00:25 INFO - PROCESS | 29074 | RSS: Main: 158105600 16:00:25 INFO - PROCESS | 29074 | 16:01:15 INFO - PROCESS | 29074 | 1456531275315 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:03:24 INFO - PROCESS | 29074 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60727/tests/dromaeo/cssquery-ext.html) 16:03:25 INFO - PROCESS | 29074 | RSS: Main: 166371328 16:03:25 INFO - PROCESS | 29074 | 16:06:27 INFO - PROCESS | 29074 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-ext.html (next: http://localhost:60727/tests/dromaeo/cssquery-jquery.html) 16:06:28 INFO - PROCESS | 29074 | RSS: Main: 163573760 16:06:28 INFO - PROCESS | 29074 | 16:09:29 INFO - PROCESS | 29074 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60727/tests/dromaeo/cssquery-mootools.html) 16:09:30 INFO - PROCESS | 29074 | RSS: Main: 162480128 16:09:30 INFO - PROCESS | 29074 | 16:12:32 INFO - PROCESS | 29074 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60727/tests/dromaeo/cssquery-prototype.html) 16:12:32 INFO - PROCESS | 29074 | RSS: Main: 160530432 16:12:32 INFO - PROCESS | 29074 | 16:15:34 INFO - PROCESS | 29074 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60727/tests/dromaeo/cssquery-yui.html) 16:15:35 INFO - PROCESS | 29074 | RSS: Main: 162988032 16:15:35 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | Cycle 1(1): loaded http://localhost:60727/tests/dromaeo/cssquery-yui.html (next: http://localhost:60727/tests/dromaeo/cssquery-dojo.html) 16:18:38 INFO - PROCESS | 29074 | RSS: Main: 164896768 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | __start_tp_report 16:18:38 INFO - PROCESS | 29074 | _x_x_mozilla_page_load 16:18:38 INFO - PROCESS | 29074 | _x_x_mozilla_page_load_details 16:18:38 INFO - PROCESS | 29074 | |i|pagename|runs| 16:18:38 INFO - PROCESS | 29074 | |0;dojo.html;3258.1854536365904;3262.5758651375318;3286;3311.966880331196;3319.601647802264;5180.689158650479;5197.844064678056;5256;5300.09898317286;5300.867478313039;5269.077911365515;5270.183121616155;5302.522772950434;5341.732913354336;5351.464853514646;4762.238041913294;4784.330193772875;4883.19427294496;5050.621203409741;5082.364704411949;4815.711057336571;4896.608271338302;4957.727324997124;4959.950400495985;4986.426560945483;4872.269159626049;4890.217565189552;4896.706197628118;4904.705717656916;4932.975335123301;4892.290617860426;4911.484294149099;4913.557779799799;4945.876353091166;4983.875403114951;4787.13831510328;4839.564439200453;4891.657583969123;4895.8776030599165;4910.558049775537;4994.675346102492;5057.216131499624;5112.130937740593;5119.59043276537;5125.359330083739;5636.323641163046;5638.379778224392;5642.802501912454;5656.604037717361;5660.433956604348;5661.490465858093;5676.744546495418;5710.543156547466;5747.1666608341975;5789.986752318369;5299.655522391071;5300.761465734051;5302.946970530284;5323.041852466593;5337.70642614656;5608.242887210175;5718.428157184248;5735.77056917727;5754.395788442237;5801.042827933428;5684.8294551163535;5712.285964254468;5713;5718.485336319751;5767.971160144172;5559.861003474864;5603.131514615241;5606.579506537026;5615.410381909841;5644.407337229614;5761.107028410603;5766.826995190151;5793.710314484343;5795.82612521625;5799.5650326225705;5528.226048353234;5709.800156994485;5760.510356619734;5773.711314434261;5802.535797136219;4290.37789520524;4301.591348821857;4306.569343065731;4314.41755363022;4323.654107671378;3787.905302367463;3894.415837624379;3897.8635747748694;3925.097227637659;3948.940765888514;5449.836504904859;5479.315085614298;5484.232207490954;5496.835094947158;5549;5646.463585959409;5676.063449530781;5687.232223649754;5712.371639119693;5734.254546908958;5427.213054107132;5427.45725427462;5431.782728690808;5439.864003399867;5466.426025267369;4840.2255639097575;4856.4415092264135;4885.65800393969;4902.632302577321;4920.827771027997;6005.879882402415;6037.275526936708;6059.515238780887;6060.878782424415;6068.726907289094;5603.243562119062;5651.858703532444;5724.484796368347;5752.568557358131;5861.677607731615;6032.155498230339;6036.788712395045;6052.273727152769;6054.66699331541;6056.031035034373;5642.435756424325;5696.515796157373;5705.286839145107;5708.971455142864;5719.113537401709;5525.4474552544425;5539;5759.769609215585;5825.563082768725;5868.23712917318;5478.698671572943;5553.389127196086;5648.237487939075;5664.235328230801;5715.342735585461;5554.055810512142;5569.888602228014;5579.218909352775;5581.944180558305;5588.888222235614;5454.263674404064;5482.122860342326;5490.231367608458;5539.030669632879;5547.140193270049;5446.128619420873;5487.5609951203005;5505.752241149078;5515.751791169488;5564.304461942257;5317.361916570037;5349.545288650508;5356.384015838228;5356.491133342326;5363.222332761649 16:18:38 INFO - PROCESS | 29074 | |1;ext.html;536.5734241278184;544.3766886914483;561.8820047789964;588.417466707959;589.2869627750422;39051.218975620504;40018.59981400185;40019.19961600766;40037.79981100098;40055.39916901249;40431;41496.17007659845;41505.58494415062;41541;41718.791406043005;8394.706185283532;8701.042885282613;8707.390482666216;8738.388312818106;8746.475211487299;8547.700830470934;8643.65425382987;8683.478991260514;8689.435186712875;8691.56542172892;8669.263112635434;8727.869081963743;8738.912610873906;8740.475571465733;8756.737297881074;8654.134586541359;8689.608967596474;8707.34694897882;8709.738707838744;8741.082186370466;8615.913840861574;8723.520206388646;8732.126787321216;8752.168543988375;8773.122687731176;35558.64441355579;35982.280354392766;35998.64001359979;36016.63983360159;36184.81907590445;2921.474134655761;2956.246157229914;2997.310618557722;3273.247153154764;3445.3798316303055;30544.930927417434;31130;31148.844255778804;31670.524942125885;32120.357592848246;3460.913477163066;3559.4482855157494;3602.6870539655024;3622.456631505269;3665.5784584772828;252025;254213;254573;255292.89414211796;256622;43137.78431107824;60930.39069609336;61332.69333653303;61370;61401;40553.1889362217;40977;41068.38397424041;41275.7936210323;41343.379849302284;13879.236641984586;14042.859571404155;14076.648083797782;14123.011389202862;14145;10414.323069000491;10421.739456513647;10428.27002109845;10476.161907047417;10529.631462898915;14103.647408814657;14282.714345713028;14538.709225815635;14607.634809129857;14739.705205895822;5689.061304884731;5715.742791574389;5726.914096288559;5776.451237132465;5825.4174582542255;884.1423818895661;995.7062666513251;1018.2159737002466;1075.7471994081384;1098.6264670012074;28880.422391552052;28947.7105228945;29101;29518;29611;1077.7682798198425;1085.03973983024;1125.983110253347;1142.1091548591946;1155.306815910447;14764.63088422798;14930.477433289783;14952.70094598102;15140.470083547023;15205.087694738351;309759;310426;311487;311988;312119;52663.736681316346;52831.207531887056;52934;52967.735161323944;53409;1328.16325714801;1355.9118657287245;1381.1436909116412;1381.9378127984264;1385.840628327735;27776.305592359546;28764.993225237016;28783;28848;29241.268968275963;48631.10951123831;48882.266765997825;49156.50843491662;49177.75411122922;49331.75334123307;282906;283480;284444;286061;287604;31915.521267181477;32567.348653026333;33085.50371744474;33415;33448.33103337871;44441.11117777691;44743.32885006793;44864.10271794481;45236.773816130706;45433.545664544254;37333.43999840059;37575;37883.431748524345;37886;38035.619643803206;36810.447843282906;37323.81338093401;37644;37840.43239351467;38257.80871095627;36895.44656830096;38669.2266154681;39069;39517.209655807295;39613.207735844546;32413.837930810194;32649.224815890917;33710.83144584261;33909.830450847585;33966.150846229044;24915.458816722665;25171.119010834533;25284.62073068942;25371.36571585651;25700 16:18:38 INFO - PROCESS | 29074 | |2;jquery.html;353.9256756081223;355.2628296285209;364.0788804325057;368.13304667508015;368.8801139629621;16475.67048659026;16758;17830;17834.10829458525;17850.910745446254;14754.336054877529;15037.849621503781;15468.613284667888;15480.922595387035;15589.986650867713;5364.704941228231;5389.191621256813;5506.366767821712;5549.889002219953;5578.497935185833;5460.6177567570285;5487.2317875497465;5508.008558459475;5513.807016754415;5530;5312.07038768214;5400.513953744162;5447.046766815811;5479.506844384005;5498.477644623755;5337.226102215196;5391.110466772978;5392.487713667196;5397.163439666858;5405;4631.1895418301665;4800.4719480857075;4802.015586804697;4818.951810481885;4910.1898186799135;20571;20705.482362940897;20931;20959.68560471594;20992.895035524878;2238.8544744591713;2385.8091352691918;2415.806735461159;2752.9538775265273;2782.4156927045346;12982.415791289415;13086.934565327208;13188.274644894624;13273;13443.193408395528;1854.360245715226;1881.5296175956012;1891.1489829576747;1928.3250862198258;1946.9318573849848;50980.74509627465;56038;59461.40538594602;60788;62194.68902655503;9313.953430232805;9652.469114198646;9985;10075.899241007495;10225.079742823033;13079.346032698328;13089.41097650608;13132.606021819362;13171.07802453819;13193.40629671648;7646;7697.769066928001;7756.108047574488;7843.9215607844335;7844.646990885424;7443.627818609048;7485.700571977169;7585.734499292498;7621.771346859603;7699.230076992256;5872.677002764889;5955.702214889238;6020.187274717945;6024.0662697282;6083.600771822417;1824.0514932235164;1834.8715589908845;1837.1181832720101;1847.8152184781684;1848.3161230344858;963.8120566489607;983.4689267795453;991.6826615482976;1052.4106500359824;1091.4051841746268;16762.664746705;16880.15599220034;16954.91522542404;17192.484225473007;17301.91349043272;932.5663566441501;934.9532523373804;979.6816034788579;1002.4937406609615;1036.7874585709912;9942.204623630092;10088.445135517617;10104.747381315527;10111.949440252753;10335.741606459898;394316;399810;409503;409823;413364;44840.3273950891;68012.3198768006;68934.65532672305;69226;69954;1014.3660212367271;1019.4189312092036;1032.442481060234;1036.7149034015706;1062.2458054781036;14677.853221468076;14958.700825983637;15147.697046059238;15318.080915145127;15428.151451670266;35367.292654147284;35509.467357990165;35671.64328356787;36431.635683642824;36552.45171322379;49735.75132124316;52503.47496524986;52506;52556.474435256685;52985.47014529805;7443.44174186949;7536.886946695694;7578.924210757822;7596.164421913696;8024.478408903403;11532.711682208012;12286.262824230575;12308.753824923631;12335.136540442441;12525.436355363849;10362.533685983997;10454;10545.209109316986;10585.788284234426;10751.677449676523;10269.948650256702;10370.066693997576;10440.164786816884;10533.26267161322;10630.096441802225;10382.948085259526;10811.297265677706;10902.672919812418;11255.606053788078;11340.319580825177;7219.0976127984;7335.816604584715;7485.438592105723;7615.314621684075;7627.618619068913;9263.722088337361;10607.598069545847;10765.317087067151;10968.616098436516;10991.230613856953 16:18:38 INFO - PROCESS | 29074 | |3;mootools.html;1460.102037247093;1477.2466042318415;1636.7954005749282;1758.8768786184971;1759.4897479730878;7266.41868650508;7344.339009489145;7444.516106453084;7464.813379665505;7482.289182527651;7463.66413511392;7480.7755767326935;7539.283768042027;7548.962255188716;7560.96219518903;2200.713907192063;2205.558888222362;2212.811910987568;2216.3018649125474;2222.511047569532;2198.395441253652;2217.124235926808;2222.7110475638146;2223.4219103033247;2226.031676220841;2181.0403422494132;2185.3771675072608;2192.112194561197;2199.3292045925987;2210.10490751246;2172.3048624440185;2174.554216385645;2174.945626359338;2175.7171567696255;2180.8146307563875;2157.7734337894453;2185.4427121084022;2191.791779780918;2193.243331050785;2203.305958623029;7469.887951680729;7498.700051997914;7498.925010749877;7510.924890751077;7527.435442341846;4433.445819272591;4547.499775024745;4555.293929440942;4574.062317224961;4589.816407343702;2962.6296712910885;2975.6726760056376;3034.984825075883;3059.632844058727;3065.432894914448;905;933.9626414943394;965.6620182935916;968.0754879090451;969.1326262994651;9891.208703303719;10027.348222365523;10041.648542301058;10044;10093.89906100937;3924.529056513237;3949;3967.662748666338;3971.5631280559114;4005.399190121505;7706.152323244439;7706.152323244551;7706.422018348646;7714.151443341228;7724;4405.31717583775;4434.17967675981;4464.955350446519;4465.397171381822;4491.416115904977;3972.880813575597;4032.2338755636333;4054.108096218827;4115.54728979812;4128;3235.2073741933377;3289.753268504872;3305.0580584533773;3358.34512270105;3374.5275661407422;963.5182408795603;964.2816102004052;971.1647982734843;980.0885176785515;992.1864071461476;1296.6563860576955;1302.4724986380343;1319.491995581708;1331.9267440290682;1351.6283022168982;6960.095187625678;6987.510874238857;6991.23096459389;6997.580145191305;7022.367986881205;412.2558781399543;414.5274387198596;418.7403809638044;422.14726252969444;438.25059148855814;5391.541718953855;5416.9729151353995;5427.945720542823;5436.184572314105;5456.208849716769;8094.271515563628;8258.710945116893;8599.269062129664;8675.089115642766;8774.649014039494;8633;8667.826643467095;8722.781930451789;8724.083971182934;8748.300135989106;6632.867342653217;6779.35596118368;6827.863442731117;6828.770821252123;6936.445084393236;6967.268436814062;6975.96512017457;7034.437245020284;7034.788956331318;7052.33002864727;7895.447318687637;7919.044009097158;8008.11910689812;8121.350291976746;8146.900168477417;7991.760247192594;8328.791780205544;8388.748337549883;8398.87401688963;8403.747887563382;6218.906716399167;6341.587796793194;6374;6381.744730210925;6595;7041.190263119807;7046.682899269443;7053.259407762111;7106.751263705745;7169.4981351304905;6258.561900666909;6326.335734747785;6418.293987661447;6583.341665833378;6599.6040237583975;6204.627722336674;6218.160548325918;6248.718807653758;6411.4229719325485;6540.313267107075;6666.366695163952;6775.728970841111;6808.217055038734;6828.624425656637;6830.795076147525;5984.551158663031;6004.42957918997;6038.245219347582;6040.848978775566;6090.23872015998;6074.3925607438905;6181.598196117238;6210.72051757681;6211.720472578835;6231.096491008869 16:18:38 INFO - PROCESS | 29074 | |4;prototype.html;282.8500894525902;296.1131411422789;298.7520358102775;305.84096269939647;306.28176925110614;6209.875802483948;6280.9371906280985;6348.619082855032;6367.745290188393;6410.294867564576;6250.84372890678;6271.278802937663;6297.842553936154;6302.46429053531;6319.178506794122;4490.820367185309;4631.143238500871;4633.675642705012;4633.9073218535605;4724.409448818907;4606.170889239936;4607.35497030416;4608.654350923677;4625.1443482955765;4625.190591646465;4541.909161816779;4568.565986231302;4596.8161273549185;4613.261878099488;4632.907341853161;4593.28804035375;4605.930911036337;4609.746463944482;4624.653151013671;4634.791434385427;3931.154801717616;3936.0553467167674;3938.1532970411213;3940.290747665419;3946.684265258801;5951.345352011275;5956.761729530814;5965.642061476282;5967.49276311514;5981.1028345748055;5236.29310043147;5308.256844041799;5345.118055520835;5346.599005074596;5349.117395629716;6564.245111812107;6567.244766851825;6580.93419065808;6610.7355705771715;6632.303608121174;4317.7193482423545;4348.717333373353;4353.673474489426;4359.193549193409;4362.192994296065;6875.209350924658;6897.896531552031;6900.930990690079;6911.827204319831;6944.270851560564;4444.777761111932;4446.221911165533;4455.554444555583;4457.3091170868565;4459.264221403497;4416.911661766747;4457.732536047847;4487.945332846778;4501.392312037899;4506;5302.072137375943;5319.255304257407;5320.600954928396;5328.333958255218;5335.439778823245;6615.536912416084;6663;6681.432078273304;6696.06255124283;6707.731690732414;1527.7784721215585;1563.2496401727235;1564.6401327694693;1565.9060456372654;1567.8980866243658;957.3729207369184;964.7781010367514;971.9659811906549;997.9671040473075;1002.9368868998885;6334.493240540745;6353.523485738496;6375.872482550416;6403.935960640427;6408.10286559882;6806.965965170241;6853.040574319599;6858.108445902001;6867.896981545281;6870.072540207108;6195.411435913581;6352;6358.300586935434;6362.204724409449;6482.092507049017;3704.481372607837;3722.4230244312175;3723.7765734056043;3729.850805967731;3742.9625703742613;7283.526570772883;7303.233160518175;7307.671154798047;7308.5614863108385;7323.048003759477;7044.119485064367;7091;7098.183708873546;7105.680244388912;7112.50212485121;6935.479839011993;7220.819479513054;7240.348368646847;7294.1247050354295;7308.342249197598;6888.896666550106;6897.48268879826;6935.341142591647;6960.860782784214;6978.197507286727;6844.178698556205;6905.516613836983;6905.620190889549;6915.170179578483;6924.515283930278;7306.525075870051;7345.3021962913435;7352.411807055316;7362.558246505227;7373.963130184315;4442.155990361821;4482.058767658697;4503.459584849839;4526.683132180848;4529.36588877564;6846.212685541027;6862.656867156722;6862.794116176523;6868.793936181923;6876.724931002704;6655.134832471747;6668.499862510234;6673.933260667525;6687.264400915993;6690.397864192246;6605.141331626858;6636.734530618721;6643.734250629921;6654.3012983637955;6657.833554161185;6409.134766806422;6503.479721622353;6541.6402097883165;6561.868762624626;6643.202815662152;6736.393724564617;6738.764143254963;6768.56004359715;6769.966150169218;6795.490338224752;6534.705938232886;6563.310852360433;6574.27682954865;6587.374199451045;6630.668466576555 16:18:38 INFO - PROCESS | 29074 | |5;yui.html;661.0414898397325;666.1440049536344;740.5852722475413;844.8437039147758;854.2226573817825;13331.80002299965;13408.195508269486;13505.729885402297;13525;13550.186988780668;13447.932760336209;13448.260345680983;13481.05632605718;13509;13546.254955977418;668.682375871462;824.2334628795218;844.2275318083977;845.5391811462767;847.5338563789921;828.0891019878146;830.6179157587487;833.708202129253;836.8535506286375;837.0875745437472;862.7498025572577;863.1368631368631;867.2454964181171;868.6178081644088;870.8693695945595;855.5337341149088;863.995680021599;864.1660797330575;865.2299453486402;865.9610317535726;639.4788247578256;640.6508452893138;641.0992555459587;641.1920979565781;642.1042645509535;13877.930610346984;13880.167189968533;13895;13902.652433689138;13931.442742290295;13453.260070696108;13454;13477.326133693276;13836.930815345959;14065.36705848229;10981.231313808037;11834.704132396673;12101.939490302491;12332.568360107443;12516.561920332835;3623.8912832615065;3675.2833197526493;3689.612590677994;3774.924501509982;3785.470034195215;51131.74434127843;51462.74268628671;52773.208401874006;52828;53055.73472132653;10093.192544596415;10102.898971010343;10136.341137826164;10240.078392944672;10322.587096516056;18108.547286317946;18303.54241143982;18307;18337.816621833612;18369.26522939094;7692.846143077107;7998.5600791957;7999.3200577950365;8087.110417854032;8257.95871020641;4427.070315233773;4500;4527.275635898241;4541.636669066533;4623.53764623535;3133.905982820519;3146.0404576604355;3148.3860647174038;3149.165471150147;3155.021943197616;552.0614954577235;565.9462351076642;573.2948473377685;577.8150991682621;581.9621724587888;648.6853875870199;684.1687349869932;685.5064353665352;686.2965460403027;695.7043256615918;8210.220029097227;8502.617382217815;8545.718142278583;8599.742007739778;8695.434796738318;643.6266965160196;663.6416335179046;676.4317972902687;681.1859827506181;698.322627051759;3900.473436086092;4054.3715724062818;4084.673226141961;4115.691323150776;4169.603887630731;53555.19667204995;55562.72218638881;56213.718931405085;56305;57064.42935570591;48572.757136214095;49648.50351496439;49730;49916;50061.24908126381;45015;45781.31328030082;46007.07985840264;46123.53876461193;46316.536834631224;7796.181400952818;8063.758087257392;8147.79630509242;8203.014426538777;8211.548364839991;34456;34492.65507344995;34545.30909381848;34957.82521087378;35080.64919350876;39039.80480097581;40046.59953400429;43323.133537329704;43371.783141084095;43622;9791.51042447889;9842.261830362608;9859.260555458513;9911.909689934246;11564.710882228012;11984.880151198377;12025.398730063636;12154.635360939186;12286.262824230575;12514.061445391813;10985.83521247166;11270.098392128446;11334.489947952527;11629.651110466699;11930.463129159036;10508.42203678805;10586.4706764663;11554.884451155716;11568.88431115678;11693.649190524298;11085.722856928318;11259.718507037389;11487.770244594894;11512.481938312629;11640.301581905112;9343.71968840936;9530.95234523823;9620.663276785279;9802.607895684378;9867.358621689567;9212.008156258817;9506.01065807411;9985.450800205768;10026.248031397528;10052.296339256181 16:18:38 INFO - PROCESS | 29074 | __end_tp_report 16:18:38 INFO - PROCESS | 29074 | __start_cc_report 16:18:38 INFO - PROCESS | 29074 | _x_x_mozilla_cycle_collect,316 16:18:38 INFO - PROCESS | 29074 | __end_cc_report 16:18:38 INFO - PROCESS | 29074 | __startTimestamp1456532318406__endTimestamp 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | ------- Summary: start ------- 16:18:38 INFO - PROCESS | 29074 | Number of tests: 6 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | [#0] dojo.html Cycles:165 Average:5306.96 Median:5487.56 stddev:588.11 (10.7%) stddev-sans-first:567.52 16:18:38 INFO - PROCESS | 29074 | Values: 3258.2 3262.6 3286.0 3312.0 3319.6 5180.7 5197.8 5256.0 5300.1 5300.9 5269.1 5270.2 5302.5 5341.7 5351.5 4762.2 4784.3 4883.2 5050.6 5082.4 4815.7 4896.6 4957.7 4960.0 4986.4 4872.3 4890.2 4896.7 4904.7 4933.0 4892.3 4911.5 4913.6 4945.9 4983.9 4787.1 4839.6 4891.7 4895.9 4910.6 4994.7 5057.2 5112.1 5119.6 5125.4 5636.3 5638.4 5642.8 5656.6 5660.4 5661.5 5676.7 5710.5 5747.2 5790.0 5299.7 5300.8 5302.9 5323.0 5337.7 5608.2 5718.4 5735.8 5754.4 5801.0 5684.8 5712.3 5713.0 5718.5 5768.0 5559.9 5603.1 5606.6 5615.4 5644.4 5761.1 5766.8 5793.7 5795.8 5799.6 5528.2 5709.8 5760.5 5773.7 5802.5 4290.4 4301.6 4306.6 4314.4 4323.7 3787.9 3894.4 3897.9 3925.1 3948.9 5449.8 5479.3 5484.2 5496.8 5549.0 5646.5 5676.1 5687.2 5712.4 5734.3 5427.2 5427.5 5431.8 5439.9 5466.4 4840.2 4856.4 4885.7 4902.6 4920.8 6005.9 6037.3 6059.5 6060.9 6068.7 5603.2 5651.9 5724.5 5752.6 5861.7 6032.2 6036.8 6052.3 6054.7 6056.0 5642.4 5696.5 5705.3 5709.0 5719.1 5525.4 5539.0 5759.8 5825.6 5868.2 5478.7 5553.4 5648.2 5664.2 5715.3 5554.1 5569.9 5579.2 5581.9 5588.9 5454.3 5482.1 5490.2 5539.0 5547.1 5446.1 5487.6 5505.8 5515.8 5564.3 5317.4 5349.5 5356.4 5356.5 5363.2 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | [#1] ext.html Cycles:180 Average:45057.24 Median:19903.64 stddev:74290.82 (373.3%) stddev-sans-first:74424.02 16:18:38 INFO - PROCESS | 29074 | Values: 536.6 544.4 561.9 588.4 589.3 39051.2 40018.6 40019.2 40037.8 40055.4 40431.0 41496.2 41505.6 41541.0 41718.8 8394.7 8701.0 8707.4 8738.4 8746.5 8547.7 8643.7 8683.5 8689.4 8691.6 8669.3 8727.9 8738.9 8740.5 8756.7 8654.1 8689.6 8707.3 8709.7 8741.1 8615.9 8723.5 8732.1 8752.2 8773.1 35558.6 35982.3 35998.6 36016.6 36184.8 2921.5 2956.2 2997.3 3273.2 3445.4 30544.9 31130.0 31148.8 31670.5 32120.4 3460.9 3559.4 3602.7 3622.5 3665.6 252025.0 254213.0 254573.0 255292.9 256622.0 43137.8 60930.4 61332.7 61370.0 61401.0 40553.2 40977.0 41068.4 41275.8 41343.4 13879.2 14042.9 14076.6 14123.0 14145.0 10414.3 10421.7 10428.3 10476.2 10529.6 14103.6 14282.7 14538.7 14607.6 14739.7 5689.1 5715.7 5726.9 5776.5 5825.4 884.1 995.7 1018.2 1075.7 1098.6 28880.4 28947.7 29101.0 29518.0 29611.0 1077.8 1085.0 1126.0 1142.1 1155.3 14764.6 14930.5 14952.7 15140.5 15205.1 309759.0 310426.0 311487.0 311988.0 312119.0 52663.7 52831.2 52934.0 52967.7 53409.0 1328.2 1355.9 1381.1 1381.9 1385.8 27776.3 28765.0 28783.0 28848.0 29241.3 48631.1 48882.3 49156.5 49177.8 49331.8 282906.0 283480.0 284444.0 286061.0 287604.0 31915.5 32567.3 33085.5 33415.0 33448.3 44441.1 44743.3 44864.1 45236.8 45433.5 37333.4 37575.0 37883.4 37886.0 38035.6 36810.4 37323.8 37644.0 37840.4 38257.8 36895.4 38669.2 39069.0 39517.2 39613.2 32413.8 32649.2 33710.8 33909.8 33966.2 24915.5 25171.1 25284.6 25371.4 25700.0 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | [#2] jquery.html Cycles:180 Average:24293.31 Median:17861.28 stddev:66384.22 (371.7%) stddev-sans-first:66546.11 16:18:38 INFO - PROCESS | 29074 | Values: 353.9 355.3 364.1 368.1 368.9 16475.7 16758.0 17830.0 17834.1 17850.9 14754.3 15037.8 15468.6 15480.9 15590.0 5364.7 5389.2 5506.4 5549.9 5578.5 5460.6 5487.2 5508.0 5513.8 5530.0 5312.1 5400.5 5447.0 5479.5 5498.5 5337.2 5391.1 5392.5 5397.2 5405.0 4631.2 4800.5 4802.0 4819.0 4910.2 20571.0 20705.5 20931.0 20959.7 20992.9 2238.9 2385.8 2415.8 2753.0 2782.4 12982.4 13086.9 13188.3 13273.0 13443.2 1854.4 1881.5 1891.1 1928.3 1946.9 50980.7 56038.0 59461.4 60788.0 62194.7 9314.0 9652.5 9985.0 10075.9 10225.1 13079.3 13089.4 13132.6 13171.1 13193.4 7646.0 7697.8 7756.1 7843.9 7844.6 7443.6 7485.7 7585.7 7621.8 7699.2 5872.7 5955.7 6020.2 6024.1 6083.6 1824.1 1834.9 1837.1 1847.8 1848.3 963.8 983.5 991.7 1052.4 1091.4 16762.7 16880.2 16954.9 17192.5 17301.9 932.6 935.0 979.7 1002.5 1036.8 9942.2 10088.4 10104.7 10111.9 10335.7 394316.0 399810.0 409503.0 409823.0 413364.0 44840.3 68012.3 68934.7 69226.0 69954.0 1014.4 1019.4 1032.4 1036.7 1062.2 14677.9 14958.7 15147.7 15318.1 15428.2 35367.3 35509.5 35671.6 36431.6 36552.5 49735.8 52503.5 52506.0 52556.5 52985.5 7443.4 7536.9 7578.9 7596.2 8024.5 11532.7 12286.3 12308.8 12335.1 12525.4 10362.5 10454.0 10545.2 10585.8 10751.7 10269.9 10370.1 10440.2 10533.3 10630.1 10382.9 10811.3 10902.7 11255.6 11340.3 7219.1 7335.8 7485.4 7615.3 7627.6 9263.7 10607.6 10765.3 10968.6 10991.2 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | [#3] mootools.html Cycles:180 Average:5131.18 Median:6225.00 stddev:2645.56 (42.5%) stddev-sans-first:2638.59 16:18:38 INFO - PROCESS | 29074 | Values: 1460.1 1477.2 1636.8 1758.9 1759.5 7266.4 7344.3 7444.5 7464.8 7482.3 7463.7 7480.8 7539.3 7549.0 7561.0 2200.7 2205.6 2212.8 2216.3 2222.5 2198.4 2217.1 2222.7 2223.4 2226.0 2181.0 2185.4 2192.1 2199.3 2210.1 2172.3 2174.6 2174.9 2175.7 2180.8 2157.8 2185.4 2191.8 2193.2 2203.3 7469.9 7498.7 7498.9 7510.9 7527.4 4433.4 4547.5 4555.3 4574.1 4589.8 2962.6 2975.7 3035.0 3059.6 3065.4 905.0 934.0 965.7 968.1 969.1 9891.2 10027.3 10041.6 10044.0 10093.9 3924.5 3949.0 3967.7 3971.6 4005.4 7706.2 7706.2 7706.4 7714.2 7724.0 4405.3 4434.2 4465.0 4465.4 4491.4 3972.9 4032.2 4054.1 4115.5 4128.0 3235.2 3289.8 3305.1 3358.3 3374.5 963.5 964.3 971.2 980.1 992.2 1296.7 1302.5 1319.5 1331.9 1351.6 6960.1 6987.5 6991.2 6997.6 7022.4 412.3 414.5 418.7 422.1 438.3 5391.5 5417.0 5427.9 5436.2 5456.2 8094.3 8258.7 8599.3 8675.1 8774.6 8633.0 8667.8 8722.8 8724.1 8748.3 6632.9 6779.4 6827.9 6828.8 6936.4 6967.3 6976.0 7034.4 7034.8 7052.3 7895.4 7919.0 8008.1 8121.4 8146.9 7991.8 8328.8 8388.7 8398.9 8403.7 6218.9 6341.6 6374.0 6381.7 6595.0 7041.2 7046.7 7053.3 7106.8 7169.5 6258.6 6326.3 6418.3 6583.3 6599.6 6204.6 6218.2 6248.7 6411.4 6540.3 6666.4 6775.7 6808.2 6828.6 6830.8 5984.6 6004.4 6038.2 6040.8 6090.2 6074.4 6181.6 6210.7 6211.7 6231.1 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | [#4] prototype.html Cycles:180 Average:5513.79 Median:6371.81 stddev:1754.71 (27.5%) stddev-sans-first:1715.14 16:18:38 INFO - PROCESS | 29074 | Values: 282.9 296.1 298.8 305.8 306.3 6209.9 6280.9 6348.6 6367.7 6410.3 6250.8 6271.3 6297.8 6302.5 6319.2 4490.8 4631.1 4633.7 4633.9 4724.4 4606.2 4607.4 4608.7 4625.1 4625.2 4541.9 4568.6 4596.8 4613.3 4632.9 4593.3 4605.9 4609.7 4624.7 4634.8 3931.2 3936.1 3938.2 3940.3 3946.7 5951.3 5956.8 5965.6 5967.5 5981.1 5236.3 5308.3 5345.1 5346.6 5349.1 6564.2 6567.2 6580.9 6610.7 6632.3 4317.7 4348.7 4353.7 4359.2 4362.2 6875.2 6897.9 6900.9 6911.8 6944.3 4444.8 4446.2 4455.6 4457.3 4459.3 4416.9 4457.7 4487.9 4501.4 4506.0 5302.1 5319.3 5320.6 5328.3 5335.4 6615.5 6663.0 6681.4 6696.1 6707.7 1527.8 1563.2 1564.6 1565.9 1567.9 957.4 964.8 972.0 998.0 1002.9 6334.5 6353.5 6375.9 6403.9 6408.1 6807.0 6853.0 6858.1 6867.9 6870.1 6195.4 6352.0 6358.3 6362.2 6482.1 3704.5 3722.4 3723.8 3729.9 3743.0 7283.5 7303.2 7307.7 7308.6 7323.0 7044.1 7091.0 7098.2 7105.7 7112.5 6935.5 7220.8 7240.3 7294.1 7308.3 6888.9 6897.5 6935.3 6960.9 6978.2 6844.2 6905.5 6905.6 6915.2 6924.5 7306.5 7345.3 7352.4 7362.6 7374.0 4442.2 4482.1 4503.5 4526.7 4529.4 6846.2 6862.7 6862.8 6868.8 6876.7 6655.1 6668.5 6673.9 6687.3 6690.4 6605.1 6636.7 6643.7 6654.3 6657.8 6409.1 6503.5 6541.6 6561.9 6643.2 6736.4 6738.8 6768.6 6770.0 6795.5 6534.7 6563.3 6574.3 6587.4 6630.7 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | [#5] yui.html Cycles:180 Average:13818.19 Median:25373.54 stddev:15774.14 (62.2%) stddev-sans-first:15787.44 16:18:38 INFO - PROCESS | 29074 | Values: 661.0 666.1 740.6 844.8 854.2 13331.8 13408.2 13505.7 13525.0 13550.2 13447.9 13448.3 13481.1 13509.0 13546.3 668.7 824.2 844.2 845.5 847.5 828.1 830.6 833.7 836.9 837.1 862.7 863.1 867.2 868.6 870.9 855.5 864.0 864.2 865.2 866.0 639.5 640.7 641.1 641.2 642.1 13877.9 13880.2 13895.0 13902.7 13931.4 13453.3 13454.0 13477.3 13836.9 14065.4 10981.2 11834.7 12101.9 12332.6 12516.6 3623.9 3675.3 3689.6 3774.9 3785.5 51131.7 51462.7 52773.2 52828.0 53055.7 10093.2 10102.9 10136.3 10240.1 10322.6 18108.5 18303.5 18307.0 18337.8 18369.3 7692.8 7998.6 7999.3 8087.1 8258.0 4427.1 4500.0 4527.3 4541.6 4623.5 3133.9 3146.0 3148.4 3149.2 3155.0 552.1 565.9 573.3 577.8 582.0 648.7 684.2 685.5 686.3 695.7 8210.2 8502.6 8545.7 8599.7 8695.4 643.6 663.6 676.4 681.2 698.3 3900.5 4054.4 4084.7 4115.7 4169.6 53555.2 55562.7 56213.7 56305.0 57064.4 48572.8 49648.5 49730.0 49916.0 50061.2 45015.0 45781.3 46007.1 46123.5 46316.5 7796.2 8063.8 8147.8 8203.0 8211.5 34456.0 34492.7 34545.3 34957.8 35080.6 39039.8 40046.6 43323.1 43371.8 43622.0 9791.5 9842.3 9859.3 9911.9 11564.7 11984.9 12025.4 12154.6 12286.3 12514.1 10985.8 11270.1 11334.5 11629.7 11930.5 10508.4 10586.5 11554.9 11568.9 11693.6 11085.7 11259.7 11487.8 11512.5 11640.3 9343.7 9531.0 9620.7 9802.6 9867.4 9212.0 9506.0 9985.5 10026.2 10052.3 16:18:38 INFO - PROCESS | 29074 | -------- Summary: end -------- 16:18:38 INFO - PROCESS | 29074 | 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:38 INFO - PROCESS | 29074 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:39 INFO - TEST-INFO | 29074: exit 0 16:18:39 INFO - TEST-OK | dromaeo_css | took 1111032ms 16:18:39 INFO - TEST-START | kraken 16:18:39 INFO - operating with platform_type : linux_ 16:18:39 INFO - Initialising browser for kraken test... 16:18:39 INFO - TEST-INFO | started process 29313 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsf4zaV/profile http://localhost:60727/getInfo.html) 16:18:42 INFO - PROCESS | 29313 | 16:18:42 INFO - PROCESS | 29313 | (process:29382): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:43 INFO - PROCESS | 29313 | __metrics Screen width/height:1600/1200 16:18:43 INFO - PROCESS | 29313 | colorDepth:24 16:18:43 INFO - PROCESS | 29313 | Browser inner width/height: 1024/697 16:18:43 INFO - PROCESS | 29313 | __metrics 16:18:43 ERROR - PROCESS | 29313 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:43 INFO - PROCESS | 29313 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:18:44 INFO - TEST-INFO | 29313: exit 0 16:18:44 INFO - Browser initialized. 16:18:44 INFO - Running cycle 1/1 for kraken test... 16:18:44 INFO - TEST-INFO | started process 29433 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsf4zaV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:45 INFO - PROCESS | 29433 | 16:18:45 INFO - PROCESS | 29433 | (process:29490): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:18:56 INFO - PROCESS | 29433 | RSS: Main: 158629888 16:18:56 INFO - PROCESS | 29433 | 16:18:58 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:59 INFO - PROCESS | 29433 | RSS: Main: 163966976 16:18:59 INFO - PROCESS | 29433 | 16:19:02 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-dft) 16:19:02 INFO - PROCESS | 29433 | RSS: Main: 167108608 16:19:02 INFO - PROCESS | 29433 | 16:19:05 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-fft) 16:19:06 INFO - PROCESS | 29433 | RSS: Main: 161685504 16:19:06 INFO - PROCESS | 29433 | 16:19:08 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60727/tests/kraken/driver.html?testName=audio-oscillator) 16:19:09 INFO - PROCESS | 29433 | RSS: Main: 162508800 16:19:09 INFO - PROCESS | 29433 | 16:19:11 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60727/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:11 INFO - PROCESS | 29433 | RSS: Main: 162758656 16:19:11 INFO - PROCESS | 29433 | 16:19:14 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60727/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:15 INFO - PROCESS | 29433 | RSS: Main: 163221504 16:19:15 INFO - PROCESS | 29433 | 16:19:18 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60727/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:19 INFO - PROCESS | 29433 | RSS: Main: 162463744 16:19:19 INFO - PROCESS | 29433 | 16:19:22 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60727/tests/kraken/driver.html?testName=json-parse-financial) 16:19:22 INFO - PROCESS | 29433 | RSS: Main: 163852288 16:19:22 INFO - PROCESS | 29433 | 16:19:24 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60727/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:25 INFO - PROCESS | 29433 | RSS: Main: 163901440 16:19:25 INFO - PROCESS | 29433 | 16:19:26 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:27 INFO - PROCESS | 29433 | RSS: Main: 162869248 16:19:27 INFO - PROCESS | 29433 | 16:19:29 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:30 INFO - PROCESS | 29433 | RSS: Main: 163930112 16:19:30 INFO - PROCESS | 29433 | 16:19:32 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:33 INFO - PROCESS | 29433 | RSS: Main: 163414016 16:19:33 INFO - PROCESS | 29433 | 16:19:35 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:36 INFO - PROCESS | 29433 | RSS: Main: 163168256 16:19:36 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | Cycle 1(1): loaded http://localhost:60727/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60727/tests/kraken/driver.html?testName=ai-astar) 16:19:38 INFO - PROCESS | 29433 | RSS: Main: 163557376 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | __start_tp_report 16:19:38 INFO - PROCESS | 29433 | _x_x_mozilla_page_load 16:19:38 INFO - PROCESS | 29433 | _x_x_mozilla_page_load_details 16:19:38 INFO - PROCESS | 29433 | |i|pagename|runs| 16:19:38 INFO - PROCESS | 29433 | |0;ai-astar;113;112;113;111;112;123;112;111;112;110 16:19:38 INFO - PROCESS | 29433 | |1;audio-beat-detection;146;126;160;164;127;148;151;128;171;126 16:19:38 INFO - PROCESS | 29433 | |2;audio-dft;162;162;162;165;160;162;162;164;170;162 16:19:38 INFO - PROCESS | 29433 | |3;audio-fft;74;74;74;76;72;74;138;71;72;73 16:19:38 INFO - PROCESS | 29433 | |4;audio-oscillator;96;96;150;98;96;97;150;96;96;136 16:19:38 INFO - PROCESS | 29433 | |5;imaging-gaussian-blur;120;116;115;115;115;116;116;115;116;116 16:19:38 INFO - PROCESS | 29433 | |6;imaging-darkroom;147;146;146;146;147;146;147;146;147;146 16:19:38 INFO - PROCESS | 29433 | |7;imaging-desaturate;100;96;96;98;97;96;96;97;97;97 16:19:38 INFO - PROCESS | 29433 | |8;json-parse-financial;58;59;58;57;57;57;60;60;56;55 16:19:38 INFO - PROCESS | 29433 | |9;json-stringify-tinderbox;67;67;67;68;68;68;68;67;67;68 16:19:38 INFO - PROCESS | 29433 | |10;stanford-crypto-aes;90;82;84;85;84;83;85;83;85;84 16:19:38 INFO - PROCESS | 29433 | |11;stanford-crypto-ccm;126;119;118;113;123;132;119;126;119;121 16:19:38 INFO - PROCESS | 29433 | |12;stanford-crypto-pbkdf2;141;162;153;144;143;140;154;153;153;144 16:19:38 INFO - PROCESS | 29433 | |13;stanford-crypto-sha256-iterative;72;72;73;73;70;74;69;68;68;69 16:19:38 INFO - PROCESS | 29433 | __end_tp_report 16:19:38 INFO - PROCESS | 29433 | __start_cc_report 16:19:38 INFO - PROCESS | 29433 | _x_x_mozilla_cycle_collect,794 16:19:38 INFO - PROCESS | 29433 | __end_cc_report 16:19:38 INFO - PROCESS | 29433 | __startTimestamp1456532378403__endTimestamp 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | ------- Summary: start ------- 16:19:38 INFO - PROCESS | 29433 | Number of tests: 14 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#0] ai-astar Cycles:10 Average:112.90 Median:112.00 stddev:3.67 (3.3%) stddev-sans-first:3.89 16:19:38 INFO - PROCESS | 29433 | Values: 113.0 112.0 113.0 111.0 112.0 123.0 112.0 111.0 112.0 110.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:149.50 stddev:17.13 (11.5%) stddev-sans-first:18.17 16:19:38 INFO - PROCESS | 29433 | Values: 146.0 126.0 160.0 164.0 127.0 148.0 151.0 128.0 171.0 126.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#2] audio-dft Cycles:10 Average:163.10 Median:162.00 stddev:2.77 (1.7%) stddev-sans-first:2.91 16:19:38 INFO - PROCESS | 29433 | Values: 162.0 162.0 162.0 165.0 160.0 162.0 162.0 164.0 170.0 162.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:20.50 (27.7%) stddev-sans-first:21.63 16:19:38 INFO - PROCESS | 29433 | Values: 74.0 74.0 74.0 76.0 72.0 74.0 138.0 71.0 72.0 73.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#4] audio-oscillator Cycles:10 Average:111.10 Median:96.00 stddev:23.94 (24.9%) stddev-sans-first:24.76 16:19:38 INFO - PROCESS | 29433 | Values: 96.0 96.0 150.0 98.0 96.0 97.0 150.0 96.0 96.0 136.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#5] imaging-gaussian-blur Cycles:10 Average:116.00 Median:116.00 stddev:1.49 (1.3%) stddev-sans-first:0.53 16:19:38 INFO - PROCESS | 29433 | Values: 120.0 116.0 115.0 115.0 115.0 116.0 116.0 115.0 116.0 116.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:19:38 INFO - PROCESS | 29433 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.25 (1.3%) stddev-sans-first:0.71 16:19:38 INFO - PROCESS | 29433 | Values: 100.0 96.0 96.0 98.0 97.0 96.0 96.0 97.0 97.0 97.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.64 (2.8%) stddev-sans-first:1.73 16:19:38 INFO - PROCESS | 29433 | Values: 58.0 59.0 58.0 57.0 57.0 57.0 60.0 60.0 56.0 55.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 16:19:38 INFO - PROCESS | 29433 | Values: 67.0 67.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:2.17 (2.6%) stddev-sans-first:1.05 16:19:38 INFO - PROCESS | 29433 | Values: 90.0 82.0 84.0 85.0 84.0 83.0 85.0 83.0 85.0 84.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#11] stanford-crypto-ccm Cycles:10 Average:121.60 Median:122.00 stddev:5.34 (4.4%) stddev-sans-first:5.42 16:19:38 INFO - PROCESS | 29433 | Values: 126.0 119.0 118.0 113.0 123.0 132.0 119.0 126.0 119.0 121.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.70 Median:153.00 stddev:7.24 (4.7%) stddev-sans-first:7.13 16:19:38 INFO - PROCESS | 29433 | Values: 141.0 162.0 153.0 144.0 143.0 140.0 154.0 153.0 153.0 144.0 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:72.00 stddev:2.25 (3.1%) stddev-sans-first:2.35 16:19:38 INFO - PROCESS | 29433 | Values: 72.0 72.0 73.0 73.0 70.0 74.0 69.0 68.0 68.0 69.0 16:19:38 INFO - PROCESS | 29433 | -------- Summary: end -------- 16:19:38 INFO - PROCESS | 29433 | 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:38 INFO - PROCESS | 29433 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 16:19:39 INFO - TEST-INFO | 29433: exit 0 16:19:39 INFO - TEST-OK | kraken | took 60244ms 16:19:39 INFO - SUITE-END | took 1171s 16:19:39 INFO - Completed test suite (00:19:31) 16:19:39 INFO - Working with test: dromaeo_css 16:19:39 INFO - Generating results file: dromaeo_css 16:19:39 INFO - Working with test: kraken 16:19:39 INFO - Generating results file: kraken 16:19:39 INFO - javascript benchmark 16:19:39 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:19:39 INFO - process_Request line: dromaeo_css 6864.42 graph.html#tests=[[72,63,43]] 16:19:39 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:39 INFO - process_Request line: kraken 1521.80 graph.html#tests=[[232,63,43]] 16:19:39 INFO - RETURN: dromaeo_css: 6864.42 16:19:39 INFO - RETURN: kraken: 1521.80 16:19:39 INFO - javascript benchmark 16:19:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3258.1854536365904, 3262.5758651375318, 3286.0, 3311.966880331196, 3319.601647802264, 5180.689158650479, 5197.844064678056, 5256.0, 5300.09898317286, 5300.867478313039, 5269.077911365515, 5270.183121616155, 5302.522772950434, 5341.732913354336, 5351.464853514646, 4762.238041913294, 4784.330193772875, 4883.19427294496, 5050.621203409741, 5082.364704411949, 4815.711057336571, 4896.608271338302, 4957.727324997124, 4959.950400495985, 4986.426560945483, 4872.269159626049, 4890.217565189552, 4896.706197628118, 4904.705717656916, 4932.975335123301, 4892.290617860426, 4911.484294149099, 4913.557779799799, 4945.876353091166, 4983.875403114951, 4787.13831510328, 4839.564439200453, 4891.657583969123, 4895.8776030599165, 4910.558049775537, 4994.675346102492, 5057.216131499624, 5112.130937740593, 5119.59043276537, 5125.359330083739, 5636.323641163046, 5638.379778224392, 5642.802501912454, 5656.604037717361, 5660.433956604348, 5661.490465858093, 5676.744546495418, 5710.543156547466, 5747.1666608341975, 5789.986752318369, 5299.655522391071, 5300.761465734051, 5302.946970530284, 5323.041852466593, 5337.70642614656, 5608.242887210175, 5718.428157184248, 5735.77056917727, 5754.395788442237, 5801.042827933428, 5684.8294551163535, 5712.285964254468, 5713.0, 5718.485336319751, 5767.971160144172, 5559.861003474864, 5603.131514615241, 5606.579506537026, 5615.410381909841, 5644.407337229614, 5761.107028410603, 5766.826995190151, 5793.710314484343, 5795.82612521625, 5799.5650326225705, 5528.226048353234, 5709.800156994485, 5760.510356619734, 5773.711314434261, 5802.535797136219, 4290.37789520524, 4301.591348821857, 4306.569343065731, 4314.41755363022, 4323.654107671378, 3787.905302367463, 3894.415837624379, 3897.8635747748694, 3925.097227637659, 3948.940765888514, 5449.836504904859, 5479.315085614298, 5484.232207490954, 5496.835094947158, 5549.0, 5646.463585959409, 5676.063449530781, 5687.232223649754, 5712.371639119693, 5734.254546908958, 5427.213054107132, 5427.45725427462, 5431.782728690808, 5439.864003399867, 5466.426025267369, 4840.2255639097575, 4856.4415092264135, 4885.65800393969, 4902.632302577321, 4920.827771027997, 6005.879882402415, 6037.275526936708, 6059.515238780887, 6060.878782424415, 6068.726907289094, 5603.243562119062, 5651.858703532444, 5724.484796368347, 5752.568557358131, 5861.677607731615, 6032.155498230339, 6036.788712395045, 6052.273727152769, 6054.66699331541, 6056.031035034373, 5642.435756424325, 5696.515796157373, 5705.286839145107, 5708.971455142864, 5719.113537401709, 5525.4474552544425, 5539.0, 5759.769609215585, 5825.563082768725, 5868.23712917318, 5478.698671572943, 5553.389127196086, 5648.237487939075, 5664.235328230801, 5715.342735585461, 5554.055810512142, 5569.888602228014, 5579.218909352775, 5581.944180558305, 5588.888222235614, 5454.263674404064, 5482.122860342326, 5490.231367608458, 5539.030669632879, 5547.140193270049, 5446.128619420873, 5487.5609951203005, 5505.752241149078, 5515.751791169488, 5564.304461942257, 5317.361916570037, 5349.545288650508, 5356.384015838228, 5356.491133342326, 5363.222332761649], "unit": "score", "name": "dojo.html", "value": 5269.48517173146}, {"lowerIsBetter": false, "replicates": [536.5734241278184, 544.3766886914483, 561.8820047789964, 588.417466707959, 589.2869627750422, 39051.218975620504, 40018.59981400185, 40019.19961600766, 40037.79981100098, 40055.39916901249, 40431.0, 41496.17007659845, 41505.58494415062, 41541.0, 41718.791406043005, 8394.706185283532, 8701.042885282613, 8707.390482666216, 8738.388312818106, 8746.475211487299, 8547.700830470934, 8643.65425382987, 8683.478991260514, 8689.435186712875, 8691.56542172892, 8669.263112635434, 8727.869081963743, 8738.912610873906, 8740.475571465733, 8756.737297881074, 8654.134586541359, 8689.608967596474, 8707.34694897882, 8709.738707838744, 8741.082186370466, 8615.913840861574, 8723.520206388646, 8732.126787321216, 8752.168543988375, 8773.122687731176, 35558.64441355579, 35982.280354392766, 35998.64001359979, 36016.63983360159, 36184.81907590445, 2921.474134655761, 2956.246157229914, 2997.310618557722, 3273.247153154764, 3445.3798316303055, 30544.930927417434, 31130.0, 31148.844255778804, 31670.524942125885, 32120.357592848246, 3460.913477163066, 3559.4482855157494, 3602.6870539655024, 3622.456631505269, 3665.5784584772828, 252025.0, 254213.0, 254573.0, 255292.89414211796, 256622.0, 43137.78431107824, 60930.39069609336, 61332.69333653303, 61370.0, 61401.0, 40553.1889362217, 40977.0, 41068.38397424041, 41275.7936210323, 41343.379849302284, 13879.236641984586, 14042.859571404155, 14076.648083797782, 14123.011389202862, 14145.0, 10414.323069000491, 10421.739456513647, 10428.27002109845, 10476.161907047417, 10529.631462898915, 14103.647408814657, 14282.714345713028, 14538.709225815635, 14607.634809129857, 14739.705205895822, 5689.061304884731, 5715.742791574389, 5726.914096288559, 5776.451237132465, 5825.4174582542255, 884.1423818895661, 995.7062666513251, 1018.2159737002466, 1075.7471994081384, 1098.6264670012074, 28880.422391552052, 28947.7105228945, 29101.0, 29518.0, 29611.0, 1077.7682798198425, 1085.03973983024, 1125.983110253347, 1142.1091548591946, 1155.306815910447, 14764.63088422798, 14930.477433289783, 14952.70094598102, 15140.470083547023, 15205.087694738351, 309759.0, 310426.0, 311487.0, 311988.0, 312119.0, 52663.736681316346, 52831.207531887056, 52934.0, 52967.735161323944, 53409.0, 1328.16325714801, 1355.9118657287245, 1381.1436909116412, 1381.9378127984264, 1385.840628327735, 27776.305592359546, 28764.993225237016, 28783.0, 28848.0, 29241.268968275963, 48631.10951123831, 48882.266765997825, 49156.50843491662, 49177.75411122922, 49331.75334123307, 282906.0, 283480.0, 284444.0, 286061.0, 287604.0, 31915.521267181477, 32567.348653026333, 33085.50371744474, 33415.0, 33448.33103337871, 44441.11117777691, 44743.32885006793, 44864.10271794481, 45236.773816130706, 45433.545664544254, 37333.43999840059, 37575.0, 37883.431748524345, 37886.0, 38035.619643803206, 36810.447843282906, 37323.81338093401, 37644.0, 37840.43239351467, 38257.80871095627, 36895.44656830096, 38669.2266154681, 39069.0, 39517.209655807295, 39613.207735844546, 32413.837930810194, 32649.224815890917, 33710.83144584261, 33909.830450847585, 33966.150846229044, 24915.458816722665, 25171.119010834533, 25284.62073068942, 25371.36571585651, 25700.0], "unit": "score", "name": "ext.html", "value": 17917.54440664547}, {"lowerIsBetter": false, "replicates": [353.9256756081223, 355.2628296285209, 364.0788804325057, 368.13304667508015, 368.8801139629621, 16475.67048659026, 16758.0, 17830.0, 17834.10829458525, 17850.910745446254, 14754.336054877529, 15037.849621503781, 15468.613284667888, 15480.922595387035, 15589.986650867713, 5364.704941228231, 5389.191621256813, 5506.366767821712, 5549.889002219953, 5578.497935185833, 5460.6177567570285, 5487.2317875497465, 5508.008558459475, 5513.807016754415, 5530.0, 5312.07038768214, 5400.513953744162, 5447.046766815811, 5479.506844384005, 5498.477644623755, 5337.226102215196, 5391.110466772978, 5392.487713667196, 5397.163439666858, 5405.0, 4631.1895418301665, 4800.4719480857075, 4802.015586804697, 4818.951810481885, 4910.1898186799135, 20571.0, 20705.482362940897, 20931.0, 20959.68560471594, 20992.895035524878, 2238.8544744591713, 2385.8091352691918, 2415.806735461159, 2752.9538775265273, 2782.4156927045346, 12982.415791289415, 13086.934565327208, 13188.274644894624, 13273.0, 13443.193408395528, 1854.360245715226, 1881.5296175956012, 1891.1489829576747, 1928.3250862198258, 1946.9318573849848, 50980.74509627465, 56038.0, 59461.40538594602, 60788.0, 62194.68902655503, 9313.953430232805, 9652.469114198646, 9985.0, 10075.899241007495, 10225.079742823033, 13079.346032698328, 13089.41097650608, 13132.606021819362, 13171.07802453819, 13193.40629671648, 7646.0, 7697.769066928001, 7756.108047574488, 7843.9215607844335, 7844.646990885424, 7443.627818609048, 7485.700571977169, 7585.734499292498, 7621.771346859603, 7699.230076992256, 5872.677002764889, 5955.702214889238, 6020.187274717945, 6024.0662697282, 6083.600771822417, 1824.0514932235164, 1834.8715589908845, 1837.1181832720101, 1847.8152184781684, 1848.3161230344858, 963.8120566489607, 983.4689267795453, 991.6826615482976, 1052.4106500359824, 1091.4051841746268, 16762.664746705, 16880.15599220034, 16954.91522542404, 17192.484225473007, 17301.91349043272, 932.5663566441501, 934.9532523373804, 979.6816034788579, 1002.4937406609615, 1036.7874585709912, 9942.204623630092, 10088.445135517617, 10104.747381315527, 10111.949440252753, 10335.741606459898, 394316.0, 399810.0, 409503.0, 409823.0, 413364.0, 44840.3273950891, 68012.3198768006, 68934.65532672305, 69226.0, 69954.0, 1014.3660212367271, 1019.4189312092036, 1032.442481060234, 1036.7149034015706, 1062.2458054781036, 14677.853221468076, 14958.700825983637, 15147.697046059238, 15318.080915145127, 15428.151451670266, 35367.292654147284, 35509.467357990165, 35671.64328356787, 36431.635683642824, 36552.45171322379, 49735.75132124316, 52503.47496524986, 52506.0, 52556.474435256685, 52985.47014529805, 7443.44174186949, 7536.886946695694, 7578.924210757822, 7596.164421913696, 8024.478408903403, 11532.711682208012, 12286.262824230575, 12308.753824923631, 12335.136540442441, 12525.436355363849, 10362.533685983997, 10454.0, 10545.209109316986, 10585.788284234426, 10751.677449676523, 10269.948650256702, 10370.066693997576, 10440.164786816884, 10533.26267161322, 10630.096441802225, 10382.948085259526, 10811.297265677706, 10902.672919812418, 11255.606053788078, 11340.319580825177, 7219.0976127984, 7335.816604584715, 7485.438592105723, 7615.314621684075, 7627.618619068913, 9263.722088337361, 10607.598069545847, 10765.317087067151, 10968.616098436516, 10991.230613856953], "unit": "score", "name": "jquery.html", "value": 8506.560216619653}, {"lowerIsBetter": false, "replicates": [1460.102037247093, 1477.2466042318415, 1636.7954005749282, 1758.8768786184971, 1759.4897479730878, 7266.41868650508, 7344.339009489145, 7444.516106453084, 7464.813379665505, 7482.289182527651, 7463.66413511392, 7480.7755767326935, 7539.283768042027, 7548.962255188716, 7560.96219518903, 2200.713907192063, 2205.558888222362, 2212.811910987568, 2216.3018649125474, 2222.511047569532, 2198.395441253652, 2217.124235926808, 2222.7110475638146, 2223.4219103033247, 2226.031676220841, 2181.0403422494132, 2185.3771675072608, 2192.112194561197, 2199.3292045925987, 2210.10490751246, 2172.3048624440185, 2174.554216385645, 2174.945626359338, 2175.7171567696255, 2180.8146307563875, 2157.7734337894453, 2185.4427121084022, 2191.791779780918, 2193.243331050785, 2203.305958623029, 7469.887951680729, 7498.700051997914, 7498.925010749877, 7510.924890751077, 7527.435442341846, 4433.445819272591, 4547.499775024745, 4555.293929440942, 4574.062317224961, 4589.816407343702, 2962.6296712910885, 2975.6726760056376, 3034.984825075883, 3059.632844058727, 3065.432894914448, 905.0, 933.9626414943394, 965.6620182935916, 968.0754879090451, 969.1326262994651, 9891.208703303719, 10027.348222365523, 10041.648542301058, 10044.0, 10093.89906100937, 3924.529056513237, 3949.0, 3967.662748666338, 3971.5631280559114, 4005.399190121505, 7706.152323244439, 7706.152323244551, 7706.422018348646, 7714.151443341228, 7724.0, 4405.31717583775, 4434.17967675981, 4464.955350446519, 4465.397171381822, 4491.416115904977, 3972.880813575597, 4032.2338755636333, 4054.108096218827, 4115.54728979812, 4128.0, 3235.2073741933377, 3289.753268504872, 3305.0580584533773, 3358.34512270105, 3374.5275661407422, 963.5182408795603, 964.2816102004052, 971.1647982734843, 980.0885176785515, 992.1864071461476, 1296.6563860576955, 1302.4724986380343, 1319.491995581708, 1331.9267440290682, 1351.6283022168982, 6960.095187625678, 6987.510874238857, 6991.23096459389, 6997.580145191305, 7022.367986881205, 412.2558781399543, 414.5274387198596, 418.7403809638044, 422.14726252969444, 438.25059148855814, 5391.541718953855, 5416.9729151353995, 5427.945720542823, 5436.184572314105, 5456.208849716769, 8094.271515563628, 8258.710945116893, 8599.269062129664, 8675.089115642766, 8774.649014039494, 8633.0, 8667.826643467095, 8722.781930451789, 8724.083971182934, 8748.300135989106, 6632.867342653217, 6779.35596118368, 6827.863442731117, 6828.770821252123, 6936.445084393236, 6967.268436814062, 6975.96512017457, 7034.437245020284, 7034.788956331318, 7052.33002864727, 7895.447318687637, 7919.044009097158, 8008.11910689812, 8121.350291976746, 8146.900168477417, 7991.760247192594, 8328.791780205544, 8388.748337549883, 8398.87401688963, 8403.747887563382, 6218.906716399167, 6341.587796793194, 6374.0, 6381.744730210925, 6595.0, 7041.190263119807, 7046.682899269443, 7053.259407762111, 7106.751263705745, 7169.4981351304905, 6258.561900666909, 6326.335734747785, 6418.293987661447, 6583.341665833378, 6599.6040237583975, 6204.627722336674, 6218.160548325918, 6248.718807653758, 6411.4229719325485, 6540.313267107075, 6666.366695163952, 6775.728970841111, 6808.217055038734, 6828.624425656637, 6830.795076147525, 5984.551158663031, 6004.42957918997, 6038.245219347582, 6040.848978775566, 6090.23872015998, 6074.3925607438905, 6181.598196117238, 6210.72051757681, 6211.720472578835, 6231.096491008869], "unit": "score", "name": "mootools.html", "value": 4154.897440901535}, {"lowerIsBetter": false, "replicates": [282.8500894525902, 296.1131411422789, 298.7520358102775, 305.84096269939647, 306.28176925110614, 6209.875802483948, 6280.9371906280985, 6348.619082855032, 6367.745290188393, 6410.294867564576, 6250.84372890678, 6271.278802937663, 6297.842553936154, 6302.46429053531, 6319.178506794122, 4490.820367185309, 4631.143238500871, 4633.675642705012, 4633.9073218535605, 4724.409448818907, 4606.170889239936, 4607.35497030416, 4608.654350923677, 4625.1443482955765, 4625.190591646465, 4541.909161816779, 4568.565986231302, 4596.8161273549185, 4613.261878099488, 4632.907341853161, 4593.28804035375, 4605.930911036337, 4609.746463944482, 4624.653151013671, 4634.791434385427, 3931.154801717616, 3936.0553467167674, 3938.1532970411213, 3940.290747665419, 3946.684265258801, 5951.345352011275, 5956.761729530814, 5965.642061476282, 5967.49276311514, 5981.1028345748055, 5236.29310043147, 5308.256844041799, 5345.118055520835, 5346.599005074596, 5349.117395629716, 6564.245111812107, 6567.244766851825, 6580.93419065808, 6610.7355705771715, 6632.303608121174, 4317.7193482423545, 4348.717333373353, 4353.673474489426, 4359.193549193409, 4362.192994296065, 6875.209350924658, 6897.896531552031, 6900.930990690079, 6911.827204319831, 6944.270851560564, 4444.777761111932, 4446.221911165533, 4455.554444555583, 4457.3091170868565, 4459.264221403497, 4416.911661766747, 4457.732536047847, 4487.945332846778, 4501.392312037899, 4506.0, 5302.072137375943, 5319.255304257407, 5320.600954928396, 5328.333958255218, 5335.439778823245, 6615.536912416084, 6663.0, 6681.432078273304, 6696.06255124283, 6707.731690732414, 1527.7784721215585, 1563.2496401727235, 1564.6401327694693, 1565.9060456372654, 1567.8980866243658, 957.3729207369184, 964.7781010367514, 971.9659811906549, 997.9671040473075, 1002.9368868998885, 6334.493240540745, 6353.523485738496, 6375.872482550416, 6403.935960640427, 6408.10286559882, 6806.965965170241, 6853.040574319599, 6858.108445902001, 6867.896981545281, 6870.072540207108, 6195.411435913581, 6352.0, 6358.300586935434, 6362.204724409449, 6482.092507049017, 3704.481372607837, 3722.4230244312175, 3723.7765734056043, 3729.850805967731, 3742.9625703742613, 7283.526570772883, 7303.233160518175, 7307.671154798047, 7308.5614863108385, 7323.048003759477, 7044.119485064367, 7091.0, 7098.183708873546, 7105.680244388912, 7112.50212485121, 6935.479839011993, 7220.819479513054, 7240.348368646847, 7294.1247050354295, 7308.342249197598, 6888.896666550106, 6897.48268879826, 6935.341142591647, 6960.860782784214, 6978.197507286727, 6844.178698556205, 6905.516613836983, 6905.620190889549, 6915.170179578483, 6924.515283930278, 7306.525075870051, 7345.3021962913435, 7352.411807055316, 7362.558246505227, 7373.963130184315, 4442.155990361821, 4482.058767658697, 4503.459584849839, 4526.683132180848, 4529.36588877564, 6846.212685541027, 6862.656867156722, 6862.794116176523, 6868.793936181923, 6876.724931002704, 6655.134832471747, 6668.499862510234, 6673.933260667525, 6687.264400915993, 6690.397864192246, 6605.141331626858, 6636.734530618721, 6643.734250629921, 6654.3012983637955, 6657.833554161185, 6409.134766806422, 6503.479721622353, 6541.6402097883165, 6561.868762624626, 6643.202815662152, 6736.393724564617, 6738.764143254963, 6768.56004359715, 6769.966150169218, 6795.490338224752, 6534.705938232886, 6563.310852360433, 6574.27682954865, 6587.374199451045, 6630.668466576555], "unit": "score", "name": "prototype.html", "value": 4912.521346874042}, {"lowerIsBetter": false, "replicates": [661.0414898397325, 666.1440049536344, 740.5852722475413, 844.8437039147758, 854.2226573817825, 13331.80002299965, 13408.195508269486, 13505.729885402297, 13525.0, 13550.186988780668, 13447.932760336209, 13448.260345680983, 13481.05632605718, 13509.0, 13546.254955977418, 668.682375871462, 824.2334628795218, 844.2275318083977, 845.5391811462767, 847.5338563789921, 828.0891019878146, 830.6179157587487, 833.708202129253, 836.8535506286375, 837.0875745437472, 862.7498025572577, 863.1368631368631, 867.2454964181171, 868.6178081644088, 870.8693695945595, 855.5337341149088, 863.995680021599, 864.1660797330575, 865.2299453486402, 865.9610317535726, 639.4788247578256, 640.6508452893138, 641.0992555459587, 641.1920979565781, 642.1042645509535, 13877.930610346984, 13880.167189968533, 13895.0, 13902.652433689138, 13931.442742290295, 13453.260070696108, 13454.0, 13477.326133693276, 13836.930815345959, 14065.36705848229, 10981.231313808037, 11834.704132396673, 12101.939490302491, 12332.568360107443, 12516.561920332835, 3623.8912832615065, 3675.2833197526493, 3689.612590677994, 3774.924501509982, 3785.470034195215, 51131.74434127843, 51462.74268628671, 52773.208401874006, 52828.0, 53055.73472132653, 10093.192544596415, 10102.898971010343, 10136.341137826164, 10240.078392944672, 10322.587096516056, 18108.547286317946, 18303.54241143982, 18307.0, 18337.816621833612, 18369.26522939094, 7692.846143077107, 7998.5600791957, 7999.3200577950365, 8087.110417854032, 8257.95871020641, 4427.070315233773, 4500.0, 4527.275635898241, 4541.636669066533, 4623.53764623535, 3133.905982820519, 3146.0404576604355, 3148.3860647174038, 3149.165471150147, 3155.021943197616, 552.0614954577235, 565.9462351076642, 573.2948473377685, 577.8150991682621, 581.9621724587888, 648.6853875870199, 684.1687349869932, 685.5064353665352, 686.2965460403027, 695.7043256615918, 8210.220029097227, 8502.617382217815, 8545.718142278583, 8599.742007739778, 8695.434796738318, 643.6266965160196, 663.6416335179046, 676.4317972902687, 681.1859827506181, 698.322627051759, 3900.473436086092, 4054.3715724062818, 4084.673226141961, 4115.691323150776, 4169.603887630731, 53555.19667204995, 55562.72218638881, 56213.718931405085, 56305.0, 57064.42935570591, 48572.757136214095, 49648.50351496439, 49730.0, 49916.0, 50061.24908126381, 45015.0, 45781.31328030082, 46007.07985840264, 46123.53876461193, 46316.536834631224, 7796.181400952818, 8063.758087257392, 8147.79630509242, 8203.014426538777, 8211.548364839991, 34456.0, 34492.65507344995, 34545.30909381848, 34957.82521087378, 35080.64919350876, 39039.80480097581, 40046.59953400429, 43323.133537329704, 43371.783141084095, 43622.0, 9791.51042447889, 9842.261830362608, 9859.260555458513, 9911.909689934246, 11564.710882228012, 11984.880151198377, 12025.398730063636, 12154.635360939186, 12286.262824230575, 12514.061445391813, 10985.83521247166, 11270.098392128446, 11334.489947952527, 11629.651110466699, 11930.463129159036, 10508.42203678805, 10586.4706764663, 11554.884451155716, 11568.88431115678, 11693.649190524298, 11085.722856928318, 11259.718507037389, 11487.770244594894, 11512.481938312629, 11640.301581905112, 9343.71968840936, 9530.95234523823, 9620.663276785279, 9802.607895684378, 9867.358621689567, 9212.008156258817, 9506.01065807411, 9985.450800205768, 10026.248031397528, 10052.296339256181], "unit": "score", "name": "yui.html", "value": 6381.406004456136}], "name": "dromaeo_css", "value": 6864.414166715079}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 112.0, 113.0, 111.0, 112.0, 123.0, 112.0, 111.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 112.9}, {"lowerIsBetter": true, "replicates": [146.0, 126.0, 160.0, 164.0, 127.0, 148.0, 151.0, 128.0, 171.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 144.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 165.0, 160.0, 162.0, 162.0, 164.0, 170.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 76.0, 72.0, 74.0, 138.0, 71.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 150.0, 98.0, 96.0, 97.0, 150.0, 96.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 111.1}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 115.0, 115.0, 116.0, 116.0, 115.0, 116.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [100.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0, 97.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 58.0, 57.0, 57.0, 57.0, 60.0, 60.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [90.0, 82.0, 84.0, 85.0, 84.0, 83.0, 85.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [126.0, 119.0, 118.0, 113.0, 123.0, 132.0, 119.0, 126.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.6}, {"lowerIsBetter": true, "replicates": [141.0, 162.0, 153.0, 144.0, 143.0, 140.0, 154.0, 153.0, 153.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 73.0, 73.0, 70.0, 74.0, 69.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1521.8}]} 16:19:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1521.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6864.42"}}} 16:19:39 INFO - Return code: 0 16:19:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:19:39 ERROR - # TBPL SUCCESS # 16:19:39 INFO - Running post-action listener: _resource_record_post_action 16:19:39 INFO - Running post-run listener: _resource_record_post_run 16:19:40 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540913664; Read time: 8; Write time: 460532 16:19:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 240762880; Read time: 0; Write time: 263940 16:19:40 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 299954176; Read time: 8; Write time: 196572 16:19:40 INFO - Running post-run listener: _upload_blobber_files 16:19:40 INFO - Blob upload gear active. 16:19:40 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:19:40 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 16:19:40 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', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:19:40 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 Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:19:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:42 INFO - (blobuploader) - INFO - Done attempting. 16:19:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:42 INFO - (blobuploader) - INFO - Done attempting. 16:19:42 INFO - (blobuploader) - INFO - Iteration through files over. 16:19:42 INFO - Return code: 0 16:19:42 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:19:42 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:19:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3237a32124752e9634bde3d44a3d0fea95948ebe4113200dbeb13fd3e763bc8711b707ac71f1e03de0edaa88903e9c4cd03ac8b1c26c475ecc8c2de7d6a7b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da652275af3e43d4875144024c6180b3e941239a21d4137508e98ba4bbe509925a2ad96ca254544aa05e9035f60247a438b8b84a6dfd37c890e29640ad735800"} 16:19:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:19:42 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:19:42 INFO - Contents: 16:19:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3237a32124752e9634bde3d44a3d0fea95948ebe4113200dbeb13fd3e763bc8711b707ac71f1e03de0edaa88903e9c4cd03ac8b1c26c475ecc8c2de7d6a7b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da652275af3e43d4875144024c6180b3e941239a21d4137508e98ba4bbe509925a2ad96ca254544aa05e9035f60247a438b8b84a6dfd37c890e29640ad735800"} 16:19:42 INFO - Running post-run listener: copy_logs_to_upload_dir 16:19:42 INFO - Copying logs to upload dir... 16:19:42 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:19:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.708912 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-02-26 16:19:42.755460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:42.759096) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3237a32124752e9634bde3d44a3d0fea95948ebe4113200dbeb13fd3e763bc8711b707ac71f1e03de0edaa88903e9c4cd03ac8b1c26c475ecc8c2de7d6a7b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da652275af3e43d4875144024c6180b3e941239a21d4137508e98ba4bbe509925a2ad96ca254544aa05e9035f60247a438b8b84a6dfd37c890e29640ad735800"} build_url:https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/VZ3WgruzQ4SdmSYV13xy5g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3237a32124752e9634bde3d44a3d0fea95948ebe4113200dbeb13fd3e763bc8711b707ac71f1e03de0edaa88903e9c4cd03ac8b1c26c475ecc8c2de7d6a7b0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/da652275af3e43d4875144024c6180b3e941239a21d4137508e98ba4bbe509925a2ad96ca254544aa05e9035f60247a438b8b84a6dfd37c890e29640ad735800"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:42.788181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:42.788973) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82e07478c745e68b1fe4678a000001bc-1456530526.628362-1032432222 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-26 16:19:42.870449) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 16:19:42.871198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-26 16:19:42.871659) ========= ========= Total master_lag: 0.32 =========