builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-009 starttime: 1456735758.47 results: success (0) buildid: 20160228223026 builduid: cebc5cea8a2c440da825d5e4bfff1f66 revision: 7882aa8df614f30d441d924afcc93c1539cc3118 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.467121) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.467542) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.467886) ========= 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009161 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.505400) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.505731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.608348) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.608686) ========= 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015100 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.662780) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.663101) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.663471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.663794) ========= 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 00:49:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 205M=0s 2016-02-29 00:49:19 (205 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156991 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.837753) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.838103) ========= 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.032755 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:18.892197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-29 00:49:18.892805) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7882aa8df614f30d441d924afcc93c1539cc3118 --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 7882aa8df614f30d441d924afcc93c1539cc3118 --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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 00:49:19,271 truncating revision to first 12 chars 2016-02-29 00:49:19,271 Setting DEBUG logging. 2016-02-29 00:49:19,271 attempt 1/10 2016-02-29 00:49:19,271 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7882aa8df614?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 00:49:20,644 unpacking tar archive at: mozilla-inbound-7882aa8df614/testing/mozharness/ program finished with exit code 0 elapsedTime=1.685438 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-29 00:49:20.597826) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:20.598603) ========= echo 7882aa8df614f30d441d924afcc93c1539cc3118 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'7882aa8df614f30d441d924afcc93c1539cc3118'] 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 7882aa8df614f30d441d924afcc93c1539cc3118 program finished with exit code 0 elapsedTime=0.004622 script_repo_revision: '7882aa8df614f30d441d924afcc93c1539cc3118' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:20.652788) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:20.653095) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 00:49:20.663799) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-29 00:49:20.664308) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:49:21 INFO - MultiFileLogger online at 20160229 00:49:21 in /builds/slave/test-pgo 00:49:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 00:49:21 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 00:49:21 INFO - {'append_to_log': False, 00:49:21 INFO - 'base_work_dir': '/builds/slave/test-pgo', 00:49:21 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:49:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 00:49:21 INFO - 'branch': 'Mozilla-Inbound', 00:49:21 INFO - 'buildbot_json_path': 'buildprops.json', 00:49:21 INFO - 'config_files': ('talos/linux_config.py',), 00:49:21 INFO - 'default_actions': ('clobber', 00:49:21 INFO - 'read-buildbot-config', 00:49:21 INFO - 'download-and-extract', 00:49:21 INFO - 'populate-webroot', 00:49:21 INFO - 'create-virtualenv', 00:49:21 INFO - 'install', 00:49:21 INFO - 'run-tests'), 00:49:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:49:21 INFO - 'download_minidump_stackwalk': True, 00:49:21 INFO - 'download_symbols': 'ondemand', 00:49:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:49:21 INFO - 'tooltool.py': '/tools/tooltool.py', 00:49:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:49:21 INFO - '/tools/misc-python/virtualenv.py')}, 00:49:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:49:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:49:21 INFO - 'installer_path': 'installer.exe', 00:49:21 INFO - 'log_level': 'info', 00:49:21 INFO - 'log_name': 'talos', 00:49:21 INFO - 'log_to_console': True, 00:49:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:49:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:49:21 INFO - 'opt_config_files': (), 00:49:21 INFO - 'pip_index': False, 00:49:21 INFO - 'sps_profile': False, 00:49:21 INFO - 'sps_profile_interval': 0, 00:49:21 INFO - 'suite': 'dromaeojs', 00:49:21 INFO - 'system_bits': '32', 00:49:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:49:21 INFO - 'title': 'talos-linux64-ix-009', 00:49:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:49:21 INFO - 'use_talos_json': True, 00:49:21 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 00:49:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:49:21 INFO - 'work_dir': 'build'} 00:49:21 INFO - ##### 00:49:21 INFO - ##### Running clobber step. 00:49:21 INFO - ##### 00:49:21 INFO - Running pre-action listener: _resource_record_pre_action 00:49:21 INFO - Running main action method: clobber 00:49:21 INFO - rmtree: /builds/slave/test-pgo/build 00:49:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 00:49:26 INFO - Running post-action listener: _resource_record_post_action 00:49:26 INFO - ##### 00:49:26 INFO - ##### Running read-buildbot-config step. 00:49:26 INFO - ##### 00:49:26 INFO - Running pre-action listener: _resource_record_pre_action 00:49:26 INFO - Running main action method: read_buildbot_config 00:49:26 INFO - Using buildbot properties: 00:49:26 INFO - { 00:49:26 INFO - "project": "", 00:49:26 INFO - "product": "firefox", 00:49:26 INFO - "script_repo_revision": "production", 00:49:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 00:49:26 INFO - "repository": "", 00:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 00:49:26 INFO - "buildid": "20160228223026", 00:49:26 INFO - "pgo_build": "True", 00:49:26 INFO - "basedir": "/builds/slave/test-pgo", 00:49:26 INFO - "buildnumber": 1550, 00:49:26 INFO - "slavename": "talos-linux64-ix-009", 00:49:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 00:49:26 INFO - "platform": "ubuntu64_hw", 00:49:26 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 00:49:26 INFO - "branch": "mozilla-inbound", 00:49:26 INFO - "repo_path": "integration/mozilla-inbound", 00:49:26 INFO - "revision": "7882aa8df614f30d441d924afcc93c1539cc3118", 00:49:26 INFO - "stage_platform": "linux64-pgo", 00:49:26 INFO - "builduid": "cebc5cea8a2c440da825d5e4bfff1f66", 00:49:26 INFO - "slavebuilddir": "test" 00:49:26 INFO - } 00:49:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 00:49:26 INFO - Running post-action listener: _resource_record_post_action 00:49:26 INFO - ##### 00:49:26 INFO - ##### Running download-and-extract step. 00:49:26 INFO - ##### 00:49:26 INFO - Running pre-action listener: _resource_record_pre_action 00:49:26 INFO - Running main action method: download_and_extract 00:49:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 00:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:26 INFO - https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:49:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/test_packages.json 00:49:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/test_packages.json 00:49:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 00:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 00:49:27 INFO - Downloaded 1448 bytes. 00:49:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 00:49:27 INFO - Using the following test package requirements: 00:49:27 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:27 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:49:27 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:49:27 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'jsshell-linux-x86_64.zip'], 00:49:27 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:49:27 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:27 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:49:27 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:49:27 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:49:27 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:27 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:27 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:49:27 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:27 INFO - https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:49:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:49:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:29 INFO - Downloaded 23371266 bytes. 00:49:29 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'] 00:49:29 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 00:49:30 INFO - Return code: 0 00:49:30 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 00:49:30 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')]} 00:49:30 INFO - https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:49:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 00:49:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:32 INFO - Downloaded 23371266 bytes. 00:49:32 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'] 00:49:32 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 00:49:33 INFO - Return code: 0 00:49:33 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')]} 00:49:33 INFO - https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:34 INFO - Downloaded 10713410 bytes. 00:49:34 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'] 00:49:34 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 00:49:35 INFO - Return code: 0 00:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:35 INFO - https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:49:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:49:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FL5-_dQHTqGhUpngwBY9UQ/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 00:49:36 INFO - Downloaded 56637003 bytes. 00:49:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:49:36 INFO - mkdir: /builds/slave/test-pgo/properties 00:49:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 00:49:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 00:49:36 INFO - Contents: 00:49:36 INFO - build_url:https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 00:49:37 INFO - Running post-action listener: _resource_record_post_action 00:49:37 INFO - Running post-action listener: set_extra_try_arguments 00:49:37 INFO - ##### 00:49:37 INFO - ##### Running populate-webroot step. 00:49:37 INFO - ##### 00:49:37 INFO - Running pre-action listener: _resource_record_pre_action 00:49:37 INFO - Running main action method: populate_webroot 00:49:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:37 INFO - '--tppagecycles', 00:49:37 INFO - '7'], 00:49:37 INFO - 'tests': ['tsvgm']}}, 00:49:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:49:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 00:49:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:49:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'tests': ['damp', 'tps']}, 00:49:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['damp', 'tps']}, 00:49:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:49:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:37 INFO - 'other': {'tests': ['a11yr', 00:49:37 INFO - 'ts_paint', 00:49:37 INFO - 'tpaint', 00:49:37 INFO - 'sessionrestore', 00:49:37 INFO - 'sessionrestore_no_auto_restore']}, 00:49:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['a11yr', 00:49:37 INFO - 'ts_paint', 00:49:37 INFO - 'tpaint', 00:49:37 INFO - 'sessionrestore', 00:49:37 INFO - 'sessionrestore_no_auto_restore']}, 00:49:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['a11yr', 00:49:37 INFO - 'ts_paint', 00:49:37 INFO - 'tpaint', 00:49:37 INFO - 'sessionrestore', 00:49:37 INFO - 'sessionrestore_no_auto_restore']}, 00:49:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['a11yr', 00:49:37 INFO - 'ts_paint', 00:49:37 INFO - 'tpaint', 00:49:37 INFO - 'sessionrestore', 00:49:37 INFO - 'sessionrestore_no_auto_restore']}, 00:49:37 INFO - 'other_l64': {'tests': ['a11yr', 00:49:37 INFO - 'ts_paint', 00:49:37 INFO - 'tpaint', 00:49:37 INFO - 'sessionrestore', 00:49:37 INFO - 'sessionrestore_no_auto_restore']}, 00:49:37 INFO - 'other_nol64': {'tests': ['a11yr', 00:49:37 INFO - 'ts_paint', 00:49:37 INFO - 'tpaint', 00:49:37 INFO - 'sessionrestore', 00:49:37 INFO - 'sessionrestore_no_auto_restore']}, 00:49:37 INFO - 'svgr': {'tests': ['tsvgx', 00:49:37 INFO - 'tsvgr_opacity', 00:49:37 INFO - 'tart', 00:49:37 INFO - 'tscrollx', 00:49:37 INFO - 'cart']}, 00:49:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['tsvgx', 00:49:37 INFO - 'tsvgr_opacity', 00:49:37 INFO - 'tart', 00:49:37 INFO - 'tscrollx', 00:49:37 INFO - 'cart']}, 00:49:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'tests': ['tp5o']}, 00:49:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'talos_options': ['--e10s'], 00:49:37 INFO - 'tests': ['tp5o']}, 00:49:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'talos_options': ['--xperf_path', 00:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:37 INFO - 'tests': ['tp5n']}, 00:49:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:37 INFO - 'talos_options': ['--e10s', 00:49:37 INFO - '--xperf_path', 00:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:37 INFO - 'tests': ['tp5n']}}, 00:49:37 INFO - 'talos.zip': {'path': '', 00:49:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:37 INFO - Running post-action listener: _resource_record_post_action 00:49:37 INFO - ##### 00:49:37 INFO - ##### Running create-virtualenv step. 00:49:37 INFO - ##### 00:49:37 INFO - Running pre-action listener: _resource_record_pre_action 00:49:37 INFO - Running main action method: create_virtualenv 00:49:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 00:49:37 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 00:49:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 00:49:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:37 INFO - Using real prefix '/usr' 00:49:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 00:49:37 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:39 INFO - Installing pip.................done. 00:49:39 INFO - Return code: 0 00:49:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 00:49:39 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')]} 00:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:39 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')]} 00:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:39 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:39 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 00:49:39 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 00:49:39 INFO - Using env: {'DISPLAY': ':0', 00:49:39 INFO - 'HOME': '/home/cltbld', 00:49:39 INFO - 'LANG': 'en_US.UTF-8', 00:49:39 INFO - 'LANGUAGE': 'en_US:en', 00:49:39 INFO - 'LOGNAME': 'cltbld', 00:49:39 INFO - 'MAIL': '/var/mail/cltbld', 00:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:39 INFO - 'MOZ_NO_REMOTE': '1', 00:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:39 INFO - 'NO_EM_RESTART': '1', 00:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:39 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:39 INFO - 'SHELL': '/bin/bash', 00:49:39 INFO - 'SHLVL': '1', 00:49:39 INFO - 'TERM': 'linux', 00:49:39 INFO - 'TMOUT': '86400', 00:49:39 INFO - 'USER': 'cltbld', 00:49:39 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:39 INFO - '_': '/tools/buildbot/bin/python'} 00:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:39 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 00:49:39 INFO - Cleaning up... 00:49:39 INFO - Return code: 0 00:49:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 00:49:39 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')]} 00:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:39 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')]} 00:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:39 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:39 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 00:49:39 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 00:49:39 INFO - Using env: {'DISPLAY': ':0', 00:49:39 INFO - 'HOME': '/home/cltbld', 00:49:39 INFO - 'LANG': 'en_US.UTF-8', 00:49:39 INFO - 'LANGUAGE': 'en_US:en', 00:49:39 INFO - 'LOGNAME': 'cltbld', 00:49:39 INFO - 'MAIL': '/var/mail/cltbld', 00:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:39 INFO - 'MOZ_NO_REMOTE': '1', 00:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:39 INFO - 'NO_EM_RESTART': '1', 00:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:39 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:39 INFO - 'SHELL': '/bin/bash', 00:49:39 INFO - 'SHLVL': '1', 00:49:39 INFO - 'TERM': 'linux', 00:49:39 INFO - 'TMOUT': '86400', 00:49:39 INFO - 'USER': 'cltbld', 00:49:39 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:39 INFO - '_': '/tools/buildbot/bin/python'} 00:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:40 INFO - Downloading/unpacking psutil>=0.7.1 00:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:42 INFO - Installing collected packages: psutil 00:49:42 INFO - Running setup.py install for psutil 00:49:42 INFO - building 'psutil._psutil_linux' extension 00:49:42 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 00:49:42 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 00:49:42 INFO - building 'psutil._psutil_posix' extension 00:49:42 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 00:49:42 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 00:49:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:42 INFO - Successfully installed psutil 00:49:42 INFO - Cleaning up... 00:49:42 INFO - Return code: 0 00:49:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 00:49:42 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')]} 00:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:42 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')]} 00:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:42 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:42 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 00:49:42 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 00:49:42 INFO - Using env: {'DISPLAY': ':0', 00:49:42 INFO - 'HOME': '/home/cltbld', 00:49:42 INFO - 'LANG': 'en_US.UTF-8', 00:49:42 INFO - 'LANGUAGE': 'en_US:en', 00:49:42 INFO - 'LOGNAME': 'cltbld', 00:49:42 INFO - 'MAIL': '/var/mail/cltbld', 00:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:42 INFO - 'MOZ_NO_REMOTE': '1', 00:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:42 INFO - 'NO_EM_RESTART': '1', 00:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:42 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:42 INFO - 'SHELL': '/bin/bash', 00:49:42 INFO - 'SHLVL': '1', 00:49:42 INFO - 'TERM': 'linux', 00:49:42 INFO - 'TMOUT': '86400', 00:49:42 INFO - 'USER': 'cltbld', 00:49:42 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:42 INFO - '_': '/tools/buildbot/bin/python'} 00:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:49:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:49:44 INFO - Installing collected packages: mozsystemmonitor 00:49:44 INFO - Running setup.py install for mozsystemmonitor 00:49:44 INFO - Successfully installed mozsystemmonitor 00:49:44 INFO - Cleaning up... 00:49:44 INFO - Return code: 0 00:49:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 00:49: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')]} 00:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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', '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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 00:49: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 blobuploader==1.2.4 00:49:44 INFO - Using env: {'DISPLAY': ':0', 00:49:44 INFO - 'HOME': '/home/cltbld', 00:49:44 INFO - 'LANG': 'en_US.UTF-8', 00:49:44 INFO - 'LANGUAGE': 'en_US:en', 00:49:44 INFO - 'LOGNAME': 'cltbld', 00:49:44 INFO - 'MAIL': '/var/mail/cltbld', 00:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:44 INFO - 'MOZ_NO_REMOTE': '1', 00:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:44 INFO - 'NO_EM_RESTART': '1', 00:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:44 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:44 INFO - 'SHELL': '/bin/bash', 00:49:44 INFO - 'SHLVL': '1', 00:49:44 INFO - 'TERM': 'linux', 00:49:44 INFO - 'TMOUT': '86400', 00:49:44 INFO - 'USER': 'cltbld', 00:49:44 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:44 INFO - '_': '/tools/buildbot/bin/python'} 00:49:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:45 INFO - Downloading/unpacking blobuploader==1.2.4 00:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:46 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 00:49:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49: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 00:49:47 INFO - Downloading docopt-0.6.1.tar.gz 00:49:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:47 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:47 INFO - Running setup.py install for blobuploader 00:49:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 00:49:47 INFO - Running setup.py install for requests 00:49:48 INFO - Running setup.py install for docopt 00:49:48 INFO - Successfully installed blobuploader requests docopt 00:49:48 INFO - Cleaning up... 00:49:48 INFO - Return code: 0 00:49:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:48 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:48 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 00:49:48 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 00:49:48 INFO - Using env: {'DISPLAY': ':0', 00:49:48 INFO - 'HOME': '/home/cltbld', 00:49:48 INFO - 'LANG': 'en_US.UTF-8', 00:49:48 INFO - 'LANGUAGE': 'en_US:en', 00:49:48 INFO - 'LOGNAME': 'cltbld', 00:49:48 INFO - 'MAIL': '/var/mail/cltbld', 00:49:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:48 INFO - 'MOZ_NO_REMOTE': '1', 00:49:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:48 INFO - 'NO_EM_RESTART': '1', 00:49:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:48 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:48 INFO - 'SHELL': '/bin/bash', 00:49:48 INFO - 'SHLVL': '1', 00:49:48 INFO - 'TERM': 'linux', 00:49:48 INFO - 'TMOUT': '86400', 00:49:48 INFO - 'USER': 'cltbld', 00:49:48 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:48 INFO - '_': '/tools/buildbot/bin/python'} 00:49:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:48 INFO - Running setup.py (path:/tmp/pip-isokD1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:48 INFO - Running setup.py (path:/tmp/pip-ypZtPD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:48 INFO - Running setup.py (path:/tmp/pip-4H37fQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:48 INFO - Running setup.py (path:/tmp/pip-S41FCQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:48 INFO - Running setup.py (path:/tmp/pip-scyVkv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:48 INFO - Running setup.py (path:/tmp/pip-SyvyLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:48 INFO - Running setup.py (path:/tmp/pip-AvBQVU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:48 INFO - Running setup.py (path:/tmp/pip-ENdq9V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:48 INFO - Running setup.py (path:/tmp/pip-gZd7Yq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:49 INFO - Running setup.py (path:/tmp/pip-SEfNnh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:49 INFO - Running setup.py (path:/tmp/pip-Cqv3cE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:49 INFO - Running setup.py (path:/tmp/pip-_uMwf3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:49 INFO - Running setup.py (path:/tmp/pip-Ec4y4C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:49 INFO - Running setup.py (path:/tmp/pip-Z53wT6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:49 INFO - Running setup.py (path:/tmp/pip-ABrMIF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:49 INFO - Running setup.py (path:/tmp/pip-7fqGqG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:49 INFO - Running setup.py (path:/tmp/pip-UByo5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:49 INFO - Running setup.py install for manifestparser 00:49:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 00:49:49 INFO - Running setup.py install for mozcrash 00:49:49 INFO - Running setup.py install for mozdebug 00:49:49 INFO - Running setup.py install for mozdevice 00:49:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for mozfile 00:49:50 INFO - Running setup.py install for mozhttpd 00:49:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for mozinfo 00:49:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for mozInstall 00:49:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for mozleak 00:49:50 INFO - Running setup.py install for mozlog 00:49:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for moznetwork 00:49:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for mozprocess 00:49:50 INFO - Running setup.py install for mozprofile 00:49:50 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 00:49:50 INFO - Running setup.py install for mozrunner 00:49:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 00:49:51 INFO - Running setup.py install for mozscreenshot 00:49:51 INFO - Running setup.py install for moztest 00:49:51 INFO - Running setup.py install for mozversion 00:49:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 00:49:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:51 INFO - Cleaning up... 00:49:51 INFO - Return code: 0 00:49:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:51 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')]} 00:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:51 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')]} 00:49:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:51 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:51 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 00:49:51 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 00:49:51 INFO - Using env: {'DISPLAY': ':0', 00:49:51 INFO - 'HOME': '/home/cltbld', 00:49:51 INFO - 'LANG': 'en_US.UTF-8', 00:49:51 INFO - 'LANGUAGE': 'en_US:en', 00:49:51 INFO - 'LOGNAME': 'cltbld', 00:49:51 INFO - 'MAIL': '/var/mail/cltbld', 00:49:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:51 INFO - 'MOZ_NO_REMOTE': '1', 00:49:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:51 INFO - 'NO_EM_RESTART': '1', 00:49:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:51 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:51 INFO - 'SHELL': '/bin/bash', 00:49:51 INFO - 'SHLVL': '1', 00:49:51 INFO - 'TERM': 'linux', 00:49:51 INFO - 'TMOUT': '86400', 00:49:51 INFO - 'USER': 'cltbld', 00:49:51 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:51 INFO - '_': '/tools/buildbot/bin/python'} 00:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:51 INFO - Running setup.py (path:/tmp/pip-VqSQQw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 00:49:51 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)) 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:51 INFO - Running setup.py (path:/tmp/pip-ZuwrN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 00:49:51 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)) 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:51 INFO - Running setup.py (path:/tmp/pip-MddFui-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 00:49:51 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)) 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:51 INFO - Running setup.py (path:/tmp/pip-LheEte-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 00:49:51 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)) 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:51 INFO - Running setup.py (path:/tmp/pip-Y_73ib-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 00:49:51 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)) 00:49:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:51 INFO - Running setup.py (path:/tmp/pip-NXlcRE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:52 INFO - Running setup.py (path:/tmp/pip-BIXWz3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:52 INFO - Running setup.py (path:/tmp/pip-nUuqo3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:52 INFO - Running setup.py (path:/tmp/pip-n_7qqF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:52 INFO - Running setup.py (path:/tmp/pip-kUa9Em-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:52 INFO - Running setup.py (path:/tmp/pip-qLxdFR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:52 INFO - Running setup.py (path:/tmp/pip-KGNNGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:52 INFO - Running setup.py (path:/tmp/pip-hJ2IzS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:52 INFO - Running setup.py (path:/tmp/pip-BBfatG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:52 INFO - Running setup.py (path:/tmp/pip-Sv2Ekg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:52 INFO - Running setup.py (path:/tmp/pip-UjID9Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 00:49:52 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)) 00:49:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:52 INFO - Running setup.py (path:/tmp/pip-s2k3Ne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 00:49:52 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)) 00:49:52 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)) 00:49:52 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)) 00:49:52 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)) 00:49:52 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)) 00:49:52 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)) 00:49:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:54 INFO - Downloading blessings-1.6.tar.gz 00:49:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:54 INFO - Installing collected packages: blessings 00:49:54 INFO - Running setup.py install for blessings 00:49:54 INFO - Successfully installed blessings 00:49:54 INFO - Cleaning up... 00:49:54 INFO - Return code: 0 00:49:54 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 00:49:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:49:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:49:55 INFO - Reading from file tmpfile_stdout 00:49:55 INFO - Current package versions: 00:49:55 INFO - argparse == 1.2.1 00:49:55 INFO - blessings == 1.6 00:49:55 INFO - blobuploader == 1.2.4 00:49:55 INFO - docopt == 0.6.1 00:49:55 INFO - manifestparser == 1.1 00:49:55 INFO - mozInstall == 1.12 00:49:55 INFO - mozcrash == 0.16 00:49:55 INFO - mozdebug == 0.1 00:49:55 INFO - mozdevice == 0.48 00:49:55 INFO - mozfile == 1.2 00:49:55 INFO - mozhttpd == 0.7 00:49:55 INFO - mozinfo == 0.9 00:49:55 INFO - mozleak == 0.1 00:49:55 INFO - mozlog == 3.1 00:49:55 INFO - moznetwork == 0.27 00:49:55 INFO - mozprocess == 0.22 00:49:55 INFO - mozprofile == 0.28 00:49:55 INFO - mozrunner == 6.11 00:49:55 INFO - mozscreenshot == 0.1 00:49:55 INFO - mozsystemmonitor == 0.0 00:49:55 INFO - moztest == 0.7 00:49:55 INFO - mozversion == 1.4 00:49:55 INFO - psutil == 3.1.1 00:49:55 INFO - requests == 1.2.3 00:49:55 INFO - wsgiref == 0.1.2 00:49:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 00:49:55 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')]} 00:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:55 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')]} 00:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:55 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:55 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 00:49:55 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 00:49:55 INFO - Using env: {'DISPLAY': ':0', 00:49:55 INFO - 'HOME': '/home/cltbld', 00:49:55 INFO - 'LANG': 'en_US.UTF-8', 00:49:55 INFO - 'LANGUAGE': 'en_US:en', 00:49:55 INFO - 'LOGNAME': 'cltbld', 00:49:55 INFO - 'MAIL': '/var/mail/cltbld', 00:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:55 INFO - 'MOZ_NO_REMOTE': '1', 00:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:55 INFO - 'NO_EM_RESTART': '1', 00:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:55 INFO - 'SHELL': '/bin/bash', 00:49:55 INFO - 'SHLVL': '1', 00:49:55 INFO - 'TERM': 'linux', 00:49:55 INFO - 'TMOUT': '86400', 00:49:55 INFO - 'USER': 'cltbld', 00:49:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:55 INFO - '_': '/tools/buildbot/bin/python'} 00:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 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)) 00:49:55 INFO - Cleaning up... 00:49:55 INFO - Return code: 0 00:49:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 00:49:55 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')]} 00:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:55 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')]} 00:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:55 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:55 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 00:49:55 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 00:49:55 INFO - Using env: {'DISPLAY': ':0', 00:49:55 INFO - 'HOME': '/home/cltbld', 00:49:55 INFO - 'LANG': 'en_US.UTF-8', 00:49:55 INFO - 'LANGUAGE': 'en_US:en', 00:49:55 INFO - 'LOGNAME': 'cltbld', 00:49:55 INFO - 'MAIL': '/var/mail/cltbld', 00:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:55 INFO - 'MOZ_NO_REMOTE': '1', 00:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:55 INFO - 'NO_EM_RESTART': '1', 00:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:55 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:55 INFO - 'SHELL': '/bin/bash', 00:49:55 INFO - 'SHLVL': '1', 00:49:55 INFO - 'TERM': 'linux', 00:49:55 INFO - 'TMOUT': '86400', 00:49:55 INFO - 'USER': 'cltbld', 00:49:55 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:55 INFO - '_': '/tools/buildbot/bin/python'} 00:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:55 INFO - Downloading/unpacking jsonschema 00:49:55 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 00:49:55 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 00:49:55 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 00:49:55 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 00:49:55 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 00:49:55 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 00:49:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:49:57 INFO - Downloading/unpacking functools32 (from jsonschema) 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:57 INFO - Downloading functools32-3.2.3-2.tar.gz 00:49:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 00:49:57 INFO - warning: no files found matching '*.txt' 00:49:57 INFO - no previously-included directories found matching 'build' 00:49:57 INFO - no previously-included directories found matching 'dist' 00:49:57 INFO - no previously-included directories found matching '.git*' 00:49:57 INFO - Installing collected packages: jsonschema, functools32 00:49:57 INFO - Running setup.py install for functools32 00:49:57 INFO - warning: no files found matching '*.txt' 00:49:57 INFO - no previously-included directories found matching 'build' 00:49:57 INFO - no previously-included directories found matching 'dist' 00:49:57 INFO - no previously-included directories found matching '.git*' 00:49:57 INFO - Successfully installed jsonschema functools32 00:49:57 INFO - Cleaning up... 00:49:57 INFO - Return code: 0 00:49:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 00:49:57 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')]} 00:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 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')]} 00:49:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:57 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 0x7f9df4572f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ef6670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, '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': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', '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 00:49:57 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 00:49:57 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 00:49:57 INFO - Using env: {'DISPLAY': ':0', 00:49:57 INFO - 'HOME': '/home/cltbld', 00:49:57 INFO - 'LANG': 'en_US.UTF-8', 00:49:57 INFO - 'LANGUAGE': 'en_US:en', 00:49:57 INFO - 'LOGNAME': 'cltbld', 00:49:57 INFO - 'MAIL': '/var/mail/cltbld', 00:49:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:57 INFO - 'MOZ_NO_REMOTE': '1', 00:49:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:57 INFO - 'NO_EM_RESTART': '1', 00:49:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:49:57 INFO - 'PWD': '/builds/slave/test-pgo', 00:49:57 INFO - 'SHELL': '/bin/bash', 00:49:57 INFO - 'SHLVL': '1', 00:49:57 INFO - 'TERM': 'linux', 00:49:57 INFO - 'TMOUT': '86400', 00:49:57 INFO - 'USER': 'cltbld', 00:49:57 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:49:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:57 INFO - '_': '/tools/buildbot/bin/python'} 00:49:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:58 INFO - Downloading/unpacking flake8 00:49:58 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 00:49:58 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 00:49:58 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 00:49:58 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 00:49:58 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 00:49:58 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 00:49:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:49:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:49:59 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 00:49:59 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 00:49:59 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 00:49:59 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 00:49:59 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 00:49:59 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 00:50:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:50:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:50:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:50:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:50:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 00:50:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:50:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:50:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:50:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:50:00 INFO - no previously-included directories found matching 'docs/_build' 00:50:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:50:00 INFO - Running setup.py install for pep8 00:50:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:50:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:50:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:50:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:50:00 INFO - no previously-included directories found matching 'docs/_build' 00:50:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 00:50:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:50:00 INFO - Cleaning up... 00:50:00 INFO - Return code: 0 00:50:00 INFO - Running post-action listener: _resource_record_post_action 00:50:00 INFO - Running post-action listener: _start_resource_monitoring 00:50:00 INFO - Starting resource monitoring. 00:50:00 INFO - ##### 00:50:00 INFO - ##### Running install step. 00:50:00 INFO - ##### 00:50:00 INFO - Running pre-action listener: _resource_record_pre_action 00:50:00 INFO - Running main action method: install 00:50:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 00:50:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 00:50:01 INFO - Reading from file tmpfile_stdout 00:50:01 INFO - Detecting whether we're running mozinstall >=1.0... 00:50:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 00:50:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 00:50:01 INFO - Reading from file tmpfile_stdout 00:50:01 INFO - Output received: 00:50:01 INFO - Usage: mozinstall [options] installer 00:50:01 INFO - Options: 00:50:01 INFO - -h, --help show this help message and exit 00:50:01 INFO - -d DEST, --destination=DEST 00:50:01 INFO - Directory to install application into. [default: 00:50:01 INFO - "/builds/slave/test-pgo"] 00:50:01 INFO - --app=APP Application being installed. [default: firefox] 00:50:01 INFO - mkdir: /builds/slave/test-pgo/build/application 00:50:01 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'] 00:50:01 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 00:50:17 INFO - Reading from file tmpfile_stdout 00:50:17 INFO - Output received: 00:50:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 00:50:17 INFO - Running post-action listener: _resource_record_post_action 00:50:17 INFO - ##### 00:50:17 INFO - ##### Running run-tests step. 00:50:17 INFO - ##### 00:50:17 INFO - Running pre-action listener: _resource_record_pre_action 00:50:17 INFO - Running main action method: run_tests 00:50:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 00:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 00:50:17 INFO - Python 2.7.3 00:50:17 INFO - Return code: 0 00:50:17 INFO - grabbing minidump binary from tooltool 00:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:17 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 0x1f858c0>, '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 0x1f867c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f86c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 00:50:17 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 00:50:17 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 00:50:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:50:17 INFO - Return code: 0 00:50:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 00:50:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 00:50:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 00:50:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 00:50:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 00:50:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 00:50:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 00:50:18 INFO - Return code: 0 00:50:18 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 00:50:18 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 00:50:18 INFO - Using env: {'DISPLAY': ':0', 00:50:18 INFO - 'HOME': '/home/cltbld', 00:50:18 INFO - 'LANG': 'en_US.UTF-8', 00:50:18 INFO - 'LANGUAGE': 'en_US:en', 00:50:18 INFO - 'LOGNAME': 'cltbld', 00:50:18 INFO - 'MAIL': '/var/mail/cltbld', 00:50:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:50:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 00:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:18 INFO - 'MOZ_NO_REMOTE': '1', 00:50:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 00:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:18 INFO - 'NO_EM_RESTART': '1', 00:50:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 00:50:18 INFO - 'PWD': '/builds/slave/test-pgo', 00:50:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 00:50:18 INFO - 'SHELL': '/bin/bash', 00:50:18 INFO - 'SHLVL': '1', 00:50:18 INFO - 'TERM': 'linux', 00:50:18 INFO - 'TMOUT': '86400', 00:50:18 INFO - 'USER': 'cltbld', 00:50:18 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140', 00:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:18 INFO - '_': '/tools/buildbot/bin/python'} 00:50:18 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:50:18 INFO - mozversion application_buildid: 20160228223026 00:50:18 INFO - mozversion application_changeset: 7882aa8df614f30d441d924afcc93c1539cc3118 00:50:18 INFO - mozversion application_display_name: Nightly 00:50:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:50:18 INFO - mozversion application_name: Firefox 00:50:18 INFO - mozversion application_remotingname: firefox 00:50:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:50:18 INFO - mozversion application_vendor: Mozilla 00:50:18 INFO - mozversion application_version: 47.0a1 00:50:18 INFO - mozversion platform_buildid: 20160228223026 00:50:18 INFO - mozversion platform_changeset: 7882aa8df614f30d441d924afcc93c1539cc3118 00:50:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:50:18 INFO - mozversion platform_version: 47.0a1 00:50:18 INFO - using testdate: 1456735818 00:50:18 INFO - actual date: 1456735818 00:50:18 INFO - starting webserver on 'localhost:45580' 00:50:18 INFO - SUITE-START | Running 2 tests 00:50:18 INFO - TEST-START | dromaeo_css 00:50:18 INFO - operating with platform_type : linux_ 00:50:18 INFO - Initialising browser for dromaeo_css test... 00:50:18 INFO - TEST-INFO | started process 24855 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPVj7I2/profile http://localhost:45580/getInfo.html) 00:50:23 INFO - PROCESS | 24855 | __metrics Screen width/height:1600/1200 00:50:23 INFO - PROCESS | 24855 | colorDepth:24 00:50:23 INFO - PROCESS | 24855 | Browser inner width/height: 1024/697 00:50:23 INFO - PROCESS | 24855 | __metrics 00:50:24 INFO - PROCESS | 24855 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:50:24 INFO - PROCESS | 24855 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 00:50:24 INFO - PROCESS | 24855 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 00:50:24 INFO - PROCESS | 24855 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 00:50:24 INFO - PROCESS | 24855 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 00:50:24 INFO - PROCESS | 24855 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 00:50:24 INFO - PROCESS | 24855 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 00:50:24 INFO - PROCESS | 24855 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 00:50:25 INFO - TEST-INFO | 24855: exit 0 00:50:25 INFO - Browser initialized. 00:50:25 INFO - Running cycle 1/1 for dromaeo_css test... 00:50:25 INFO - TEST-INFO | started process 24949 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPVj7I2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:50:36 INFO - PROCESS | 24949 | RSS: Main: 153104384 00:50:36 INFO - PROCESS | 24949 | 00:51:28 INFO - PROCESS | 24949 | 1456735888336 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] 00:53:36 INFO - PROCESS | 24949 | Cycle 1(1): loaded http://localhost:45580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45580/tests/dromaeo/cssquery-ext.html) 00:53:37 INFO - PROCESS | 24949 | RSS: Main: 259141632 00:53:37 INFO - PROCESS | 24949 | 00:56:39 INFO - PROCESS | 24949 | Cycle 1(1): loaded http://localhost:45580/tests/dromaeo/cssquery-ext.html (next: http://localhost:45580/tests/dromaeo/cssquery-jquery.html) 00:56:40 INFO - PROCESS | 24949 | RSS: Main: 234999808 00:56:40 INFO - PROCESS | 24949 | 00:59:42 INFO - PROCESS | 24949 | Cycle 1(1): loaded http://localhost:45580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45580/tests/dromaeo/cssquery-mootools.html) 00:59:42 INFO - PROCESS | 24949 | RSS: Main: 235986944 00:59:42 INFO - PROCESS | 24949 | 01:02:44 INFO - PROCESS | 24949 | Cycle 1(1): loaded http://localhost:45580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45580/tests/dromaeo/cssquery-prototype.html) 01:02:45 INFO - PROCESS | 24949 | RSS: Main: 214192128 01:02:45 INFO - PROCESS | 24949 | 01:05:47 INFO - PROCESS | 24949 | Cycle 1(1): loaded http://localhost:45580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45580/tests/dromaeo/cssquery-yui.html) 01:05:48 INFO - PROCESS | 24949 | RSS: Main: 212439040 01:05:48 INFO - PROCESS | 24949 | 01:08:50 INFO - PROCESS | 24949 | Cycle 1(1): loaded http://localhost:45580/tests/dromaeo/cssquery-yui.html (next: http://localhost:45580/tests/dromaeo/cssquery-dojo.html) 01:08:51 INFO - PROCESS | 24949 | RSS: Main: 261959680 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | __start_tp_report 01:08:51 INFO - PROCESS | 24949 | _x_x_mozilla_page_load 01:08:51 INFO - PROCESS | 24949 | _x_x_mozilla_page_load_details 01:08:51 INFO - PROCESS | 24949 | |i|pagename|runs| 01:08:51 INFO - PROCESS | 24949 | |0;dojo.html;3150.5116706910435;3154.747620190384;3185.2673885006448;3186.8725250989946;3219.726323262523;5032.5219104185135;5067.315912351832;5075.79696812128;5100.4134524529645;5104.846854594359;5164.173732202848;5182.481751824816;5190.195519694444;5193.766280517376;5209.557187639055;4682.882927926795;4717.127331443694;4773.236282194849;4773.618110551165;4797.328374027639;4583.495815460296;4676.04141151065;4733.431988161426;4733.90532189356;4853.538913803183;4730.550597693231;4743.715377077352;4744.976275118637;4779.880502987418;4784.641151913603;4735.502772208937;4736.171170045262;4759.690620109682;4774.785134668949;4789.473157952622;4532.4787649420405;4662.8368007119925;4735.668503204777;4741.075490279397;4751.40607424072;4978.402591688984;4990.30135780991;4992.176290911995;5007.549320561167;5040.218766091261;5512.4211957744665;5526.171074338841;5526.861828454281;5528.5024347808485;5534.529564986981;5446.2375267462585;5526.115821468546;5547.140193270049;5600.327960644708;5612.859678508029;5190.169572868361;5195.740212989335;5199.376074871039;5200.6619569727845;5201.531862132389;5515.25544051556;5637.126245431965;5651.632643878134;5654;5655.095184770417;5288.524032837063;5292.153255479105;5311.840644780663;5350.705711185844;5357.276767636397;5455.781768729206;5456.91814622781;5459.808906688247;5462;5465.262189604432;5404.243405923174;5435.2934118564335;5448.182772584144;5475.0418676731415;5497.835064948058;5425.945740542623;5443.537299329522;5447.101228297287;5449.209864569615;5488.862778430571;4192.371144328315;4193.643540299109;4194.3708443733685;4229.619334259932;4233.1956928183545;3761.830717617659;3815.5039844819994;3816.3321418751607;3817.026658202141;3837.13664425502;5193.195054766442;5216.113260745682;5222.399424066205;5222.477752224823;5238.266642670029;5498.80754173602;5513.696746678971;5515.310586176728;5515.558755299567;5558.527525160407;4982.8754281143265;5155.716435596079;5210.843674689765;5225.895482090337;5293.258943747878;4694.108119457293;4699.412573428322;4703.858884233478;4721.15019296523;4737.2183589708;5776.3068431787615;5803.970980145073;5809.3609702932645;5814.30228372598;5824.5631577631;5347.304850369427;5486.341639003345;5487.067198576331;5551.22282880389;5569.136783798518;5770.422957704196;5780.450857168562;5783.710814459176;5788.305403351625;5802.82591522255;5414.75633596497;5415.6479828811;5418.620696551204;5422.864428389322;5423.538999185113;5408.296921400193;5476.370217424887;5507;5597.860053498533;5598.1602759586385;5357.732113394392;5369.48989845964;5389.0299746046085;5395.4604539545735;5402.621816472966;5373.408925018167;5373.838784836461;5374.435684253253;5384.865378365572;5421.810236641699;5042.117629414911;5309.38942021657;5316.175992721134;5371.516563509303;5393.325834270716;5397.055515284888;5429.7556609953435;5430.8099216527235;5434.972825135849;5494.230807687007;5238.738063096754;5282.735863206901;5323.813666521653;5328.280682107866;5331.573474122139 01:08:51 INFO - PROCESS | 24949 | |1;ext.html;511.3148381169232;517.1647788821055;520.0457161109364;564.8223454098205;588.3528119069025;28444.288892777666;36503.45244821323;36562.634373656256;36583.26833463329;36627.63372366276;39433.60566394335;40038.59961400385;40054.39918401226;40068.398974015414;40118.39822402659;7555.282248186413;8573.142685731424;8798.076201998794;10181.134603558707;10386.740331491697;10313.123384512326;10449.529771160278;10451.790964180711;10465.79068418635;10471.842922356132;10454.477276136162;10544.894551054467;10545.947270263676;10546.894531054706;10560.102391296748;10348.379097254114;10349.741256468611;10394.428306443142;10440.425776582322;10449.947750261237;10295.176385889112;10349.741256468573;10462.215333849916;10670.346096355077;10741.19441041925;39538.60461395407;39916.40125398121;39938.60061399378;39990.00024999369;40027;3335.099523128766;3405.744569157323;3471.861125554975;3882.592327805568;3883.0680636647285;29981.400371992655;30449.391012179854;30612;30692.846535767403;31942.88199913015;3852.653261206477;3863.98068009661;3916.255911376858;3967.2858885400615;3991.940120898189;266541.6672916642;267138;268632;268780;268849;57480;57953.710231448575;57954.42045579575;57977.42022579804;58144.4185558139;64255;64398.67800661061;64500.354996450376;64533.67733161304;64551;14478.638034049023;15042.548723538312;15101.924490377478;15113.924430377778;16745.16274186286;11903.523859045714;11954.581589644495;11984.221025633306;11992.280463172237;12008.699782505508;19134.904325478285;19167.52081197953;19325.903370483058;19358.4192474226;19406.70889936652;6533.542652014314;7320.67056982437;7719.399624391615;7801.882971755428;7827.217278272127;955.350361754014;959.1799011844912;964.4791812421214;970.854371844229;1049.8320268757116;26133.477330453283;26373.604395934075;26382;26458.33854153623;26515;1017.0846238385365;1026.4662375564665;1043;1043.186314674555;1094.3379255550278;13823.377947992365;14528.346224419927;14644.560663180122;14786.63033424173;14947.252637368088;306300;310382;310883;311127;311165;50837;51755.48244517582;51782.223266650275;51821.48178518242;52075.739621301655;1164.831099490586;1316.7234880675167;1319.663485811112;1334.0194956706812;1416.6458385403648;25256.873715631304;25813.870930645226;25953.870230648725;26248.73751262463;26352.34119147037;39888.20223595454;40140.1971960565;40204.597954020086;40232.59767402289;40352;185770;186347;191545;194537;194549;27133.72866271312;27412;30487.84756076294;30515.54226686557;31042.53436198504;36629;36823.44764828476;37192.81403593073;37358.813205933795;37471;31585.52621710722;34154.48768268428;34161.48757768586;34374;34706.82646586751;33582.832085839415;33917.83041084779;34018.489722653685;34083.659163409044;34600.65399346075;33829.492557611164;34470.31059378848;34518.82740586281;34565;34858.12854678552;30544.847275763477;31209.687903120677;31476.685233147375;31549.211269718442;31570;23279.41801454977;23860.284191474282;24002.51994960126;24055.278341649777;24151.15470958508 01:08:51 INFO - PROCESS | 24949 | |2;jquery.html;344.6088689337601;346.23827579325484;347.3833944748073;348.7837540724751;354.59398988158546;16421.589460263498;16612.750808737877;17115.657686846273;18016.09919504026;18184.454466365998;14723.190224537646;14986.175760333177;15449.69100617987;15491;15506.379744810194;5328.960852633738;5347.331583552056;5459.071957767169;5490.478404551562;5491.341039075317;5372.91940620889;5404.621676482648;5421.322334708161;5450.863728406782;5463.071277882749;5342.118550439173;5385.78456861725;5388.191771234327;5394.865128371783;5405.405405405402;5211.635185537014;5285.550728188108;5344.652597581165;5369.087255166631;5411.242426060335;4727.385439892826;4743.695483741964;4748.3589715388325;4749.857504274877;4749.9762501187615;19952.603317767764;20995.475113122142;21057.368278951657;21268.468288292763;21301.573968520544;1999.6400647883374;2062.2988184017354;2063.669812829955;2180.269609680743;2870.1819981305434;8738.344624153151;9205.309601779893;10665.346871234971;13021.674458138528;13363.33183340829;1815.2376002079159;1858.6654402207598;1933.1204302042536;1937.2444746548858;1966.1349006437265;60966;63016.369836301965;63050.68474657597;63587.68206158986;64609.35390646127;9514.857277140849;9628.518574071408;9832.606695732233;9871.555779989918;10034.297599168134;12825.551105711254;12827.551035713705;12968;12969.351532423341;12990.155639883378;7421.851562968711;7427.591482468516;7476.738314158978;7544.358729508053;7742.496737712031;7485.214052524516;7617.5048621839405;7627.237276272328;7706.807329816687;7725.381969442431;4231.682623803227;4279.101388708406;4286.37847512109;4360.629346505519;4365.825366985348;1618.789557357536;1662.642531855657;1667.466410748573;1669.4490818030022;1682.1168886334528;850.1880703927734;853.4068822168533;898.725888603969;978.3689520259393;992.7567745902301;15434.536963891102;16080.678386432206;16625.6674866502;16964.321427143022;17196.53829424513;908.6683360573476;913.9268858491305;940.9858852117223;952.5808644196532;955.8470644696815;9355.204807591295;9776.657816976372;9823.852642210373;9862.211023118134;9956.850647240297;408909;414072;415042;415660;422281.10875564633;48376.27435588469;55267;56301;72414;74093.62953185308;961.403929563675;978.3347323819728;987.8567607696843;1000.9249306302056;1004.7889943111882;14729.484468043567;14812.703745925237;14859.405623775361;14963.551093467213;15447.5365739028;30285.697143028287;30437.543436848024;31513.684863151993;32870;33261.667383325854;35112;36672.44991325079;37865.81067094647;38160.618393815705;38744.80627596844;7487.438442116754;7643.847123057397;7758.379329653501;7853.175416581405;7981.241782030698;12506.374681266083;12507.499700011898;12539.435725392197;12631.557895473614;13104.2137471752;10747.946260268649;10844.186685998424;10994.120470362512;11018.944905275423;11249.156313276373;10603.575856965635;10629.468526573795;10726.87367826367;10935.418361084336;11130.666080017612;10938.507767150339;10940;11037.172212084286;11119.332840029625;11320.943395282971;7454.664540095817;7593.202713715202;7627.54234745917;7780.455368124403;7985.683038377503;9338.813223735351;11048.944755276172;11063.668089957315;11081.889181108085;11203.21577489568 01:08:51 INFO - PROCESS | 24949 | |3;mootools.html;1316.447092221267;1468.5080498033158;1485.1534625263598;1667.8582320502758;1817.0551313317067;7275.163356214037;7357.632118394085;7384.889226661598;7393.07586551681;7393.297636724503;7347.934549490334;7529.661165247563;7531.133919599248;7542.208068152847;7552.8867066994035;1941.1652989214633;2000.4298774849171;2175.6954026436233;2218.290147152916;2244.079927229836;2253.5154941687533;2254.357508110189;2254.549090181962;2260.2541161416775;2264.558411109826;2171.4896999205175;2188.671699245118;2246.1240116354634;2247.494313779403;2248.696425982496;2205.4817117977263;2241.529278851435;2246.7191601049867;2248.853824501402;2280.315905228425;2159.5572907553915;2161.8162456191244;2169.9891500542553;2172.902219400115;2173.9891300543554;7773.494722843054;7806.960965195194;7847.058352997619;7851.842963140705;7861.68553257869;4621.768911554409;4698.788554515055;4724.976375118103;4727.149113159629;4728.692634978715;2845.4735873863197;2945.617069780936;2957.216337670519;2989.865456054483;2994.9101526954228;900.6442455230213;902.6524787956619;905.7463910105181;949.3449519831295;950.9714708558685;10735.731606709895;10761.192910531663;10766.084882784973;10772.676819695422;10776.353418794897;4207.116505533811;4240.851570195028;4323.610875021263;4329.458817647794;4341.60925516705;9224.631014759469;9255.490947997925;9264.907350926405;9265.861012084824;9271.814563708824;4850.296706977469;4861.927071093936;4862.270659401047;4862.41651001882;4866.562009419098;3837.5970523094675;4180.226658068267;4251.893702657459;4256.361545768098;4276.294411422081;3506.5967413747235;3617.385044542434;3642.0712718256673;3643.1620727232885;3670.7430479866152;1130.8360287758228;1174.8825117488354;1175.7707247086737;1175.9235649682744;1179.445660539545;1332.7667658159783;1348.4875747215995;1355.3833005982253;1367.7469668111232;1373.2378529915793;7418.554886706707;7551.697932082655;7559.395248380117;7562.886556701654;7585.734499292498;442.10253186031764;457.38253357966477;460.75579942629787;462.6067842333989;465.8858579648008;5459.3994660587305;5478.506934375846;5499.697516636544;5544.3346798384455;5581.609287349846;9201.217896478875;9325.253979681609;9615.807683846284;9617.326787124974;9650.613975441043;9430;9441.669541566012;9481.525923703788;9503.952480237554;9506.572204250826;7256.201817800038;7323.450741194325;7343.265673432721;7351.191368949411;7400.925990740024;7013.894791578028;7060.470464715269;7063.081799366049;7111.431085513043;7116.928830711627;8213.301869341172;8332.416730828783;8389.454685445426;8405.159484051546;8511.574421278787;8621.655133794578;8654.82690346202;8661.393702440768;8684.652613895374;8824.86762698573;6025.276966764016;6245.28179259391;6247.406496382836;6548.0832683423405;6880.518363714492;6853.383195512428;7251.166115896739;7351.889721654286;7382.2617738225745;7439.144498382755;6655.001749737385;6706.597604143767;6735.360140786617;6786.185657721105;6824.624645644537;6618.63597502142;6626.966865165643;6668.899966500603;6670.666466676744;6723.058771771858;6890.20762612306;6943.305669433016;6945.201301850352;6955.374016338554;7022.227554969051;6516.446102081187;6567.146270984741;6568.671566421755;6575.539712220098;6575.835604109936;6319.557630965788;6390.392912673288;6390.977443609;6395.584287021329;6401.29585745577 01:08:51 INFO - PROCESS | 24949 | |4;prototype.html;309.32258354204293;313.68317998821186;314.6805991918205;315.8862809388621;317.5934803451582;5738.7991420300295;5836.182934389183;5860.208871802316;5888.35228124907;5909.615874968124;5747.2528571285675;5768.913466298009;5774.307083150017;5776.335721392041;5776.566757493184;4263.062126332202;4383.298672212431;4384.693071484998;4440.533743956878;4443;4314.3097104463295;4379.781010949456;4385.583369579885;4413.668974826901;4458.71018383804;4402.647788176954;4405.2511073117485;4405.7356558606425;4406.955930440687;4411.536788637195;4246.4691913510815;4297.828086876521;4416.293393057112;4426.490953540336;4430.800613972363;3782.0355809268463;3784.4701741756176;3787.1478917243676;3797.39241721326;3798.948567773399;5539.113741801333;5544.528715059225;5549.77800887964;5550.4449555044575;5566.777328906839;5039.538533825186;5055.34280543527;5056.292119103328;5056.570191533724;5062.82280120194;6105.603135796159;6119.908201376983;6126.663033533154;6135.3864613538735;6138.0792881067755;4151.584841515854;4190.120074784269;4191.455110835603;4194.224068547329;4195.370694395865;6218.595791273553;6350.745970161188;6370;6381.904271435932;6394.072859435356;4298.376735373354;4309;4315.762633055149;4318.050028993616;4324.35134729793;4364.607185353333;4368.628666563314;4369.60673539383;4372.038151606642;4373.453318335208;5066.46802085783;5074.985002999415;5082.542571168613;5083.8983220335385;5091.1854103343285;6160.907586386208;6173.783917562953;6176.752929882754;6186.628802271878;6188.2883468400805;1492.8731057860205;1535.3935195597676;1539.8383169767012;1542.2365928865058;1554.5880341709455;1031.3244824639723;1044.9634262800766;1045.0646671229208;1053.5733028123623;1054.8101341758404;5782.479576838105;5885.852853678607;5940.257467816523;5982.9401705983255;6048.969755151196;6372.2671892732005;6394.9680251599375;6402.327755585597;6408.679566021773;6411.903821442682;6042.969785151046;6045.78839740607;6045.8488537786025;6048.909266361008;6049.969750151221;3393.745469089828;3447.87932422364;3450.413429716954;3451.4995325677637;3458.706009989179;6606.141201643755;6782.898256526156;6791.626460544619;6792.184937807396;6798.354156355138;6508.479321654351;6532.934670653328;6542.738290468423;6545.9018114728315;6551.80344589663;6781.491388145811;6785.8642827143185;6787.287334829772;6801.557898736566;6801.775680377579;6347.809565713036;6383.457406120346;6394.87210255783;6398.776042838478;6398.904016439664;6240.251169859646;6305.873882522415;6359.55483116196;6409.230892292955;6414.871702565829;6742.460603151638;6789.626570538668;6807.693653785493;6818.215905170969;6820.897686534607;4394.340848872695;4405.80173892182;4407.449068866392;4410.29435290352;4416.116776644748;6380.074889141141;6384.361563843579;6387.233531976192;6392.456641185551;6398.872022559616;6174.197354343906;6217.689115544295;6226.439620434183;6234.659548197159;6240.563160578716;6085.178500902499;6173.84565385869;6227.96886015567;6233.906491402542;6244.1570387997035;6108;6108.5723999319625;6133.815985520441;6146.661933593517;6151;6267.655278959701;6298.590591611531;6331.081993110881;6331.493480521455;6343.746250149942;6099.725512352044;6105.267367915879;6107.175531303217;6110.358412366815;6112.235970503687 01:08:51 INFO - PROCESS | 24949 | |5;yui.html;718.7484380466834;739.412167326975;805.1169656036141;807.7495976247363;846.8814365988762;13446.932765336172;13678.658033549142;13784.793228101587;13791.241481718527;13849.376778044987;12827.102102852805;13336.466541338335;13343.866561334384;13372.665683357922;13387.129836560616;698.9755358562452;813.446856137826;845.1337379186322;861.9482831030127;867.3841572483544;849.049065047148;854.3677678517914;857.0443954990172;858.9699360522383;860.1484530314974;904.145582424609;904.606496174163;905.3436258712413;905.3571963905634;905.6920646980026;713.2582114600809;870.503812826689;881.6825942660637;884.1909652667802;885.6368888755579;657.3065415986133;657.3360905485446;658.1805651963289;658.3350815676154;658.7595527632427;13877.722445551033;13962.301884905815;13994.16035037901;14024.859751402457;14038.789418158736;13139.86860131396;13487.66280842977;13597.932010339984;13667.589972300846;13875.444982200801;10478.423686697228;10509.684709458652;10571.36571805694;10582.047615714622;10676.252662313564;3668.284684486526;3673.6326367363317;3724.2179142380132;3810.599887011879;4389.144116897174;42603;43838;43971.12057758827;44164;44361.89095272612;10149;10318.690439286684;10342.172626189888;10413.11488523484;10808.459577021118;17896.55258618545;17994.820051799576;18010.459686209433;18038.098095095193;18089.095545222684;7409.592472413961;7501.962490187623;7523.435742319348;7586.468947173756;7724.7682569523;4221.83994090619;4250.978745106255;4259.914801704011;4371.672124590605;4435.26818075014;3051.4354844353866;3053.908382748521;3056.251218451449;3071.508558630608;3084.6606873243927;527.8733104054999;534.9170878513837;540.7107197649239;542.8317221661298;542.8941356435536;674.4671709349657;677.6494902724422;689.6586189836063;711.9466040047017;745.0016977250402;8150.673973041131;8639.16115796664;8651.221390074923;8654.610542525601;8736.08271131522;615.7321565119188;668.3884245914934;700.166801506206;705.9152901651835;716.1907045039072;4011.91976160481;4072.226277007359;4085.7140000200293;4133.276676581646;4135.60711732385;58085;59194.704026479594;59245;59269.40730592639;59631;48856.511434885906;50133.24800128001;50976.23535646968;51620.74189629028;51851.48148518542;46942;47788;51315;51668.96662066738;52014.739926300885;7899.526028438312;8204.507729536246;8317.916820831715;8379.162083791573;8395.99248090233;33043.66956330406;33707.15732106717;33849.661503384654;34702.82648586842;35113.824430877685;41564.37653435261;43662.34506482469;44202.97059232957;44581;44700;10695.340928244867;10888.61889833852;11001.944990274997;11448.885511145116;11746.471408786454;9119.635214591342;11488.712782180512;12311.876881231074;12529.49882004746;12608.49566017349;10269.383836969806;10803.837942430713;11144;11193.27243729155;11708.180427370002;10919.727006824574;11088.445577721242;11123.610673626385;11161.162912781412;11588.304701717923;11045.171612128961;11103.278286911647;11128.944355278172;11658.533658653898;12157.1489995703;9775.804483910424;9990.753005273169;10007.899921000697;10215.489225538842;10316.587336506456;9122.361434699507;9279.72160835176;9468.810623787624;9484.715458536255;9576.281778866753 01:08:51 INFO - PROCESS | 24949 | __end_tp_report 01:08:51 INFO - PROCESS | 24949 | __start_cc_report 01:08:51 INFO - PROCESS | 24949 | _x_x_mozilla_cycle_collect,818 01:08:51 INFO - PROCESS | 24949 | __end_cc_report 01:08:51 INFO - PROCESS | 24949 | __startTimestamp1456736931020__endTimestamp 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | ------- Summary: start ------- 01:08:51 INFO - PROCESS | 24949 | Number of tests: 6 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | [#0] dojo.html Cycles:165 Average:5125.38 Median:5316.18 stddev:554.21 (10.4%) stddev-sans-first:533.82 01:08:51 INFO - PROCESS | 24949 | Values: 3150.5 3154.7 3185.3 3186.9 3219.7 5032.5 5067.3 5075.8 5100.4 5104.8 5164.2 5182.5 5190.2 5193.8 5209.6 4682.9 4717.1 4773.2 4773.6 4797.3 4583.5 4676.0 4733.4 4733.9 4853.5 4730.6 4743.7 4745.0 4779.9 4784.6 4735.5 4736.2 4759.7 4774.8 4789.5 4532.5 4662.8 4735.7 4741.1 4751.4 4978.4 4990.3 4992.2 5007.5 5040.2 5512.4 5526.2 5526.9 5528.5 5534.5 5446.2 5526.1 5547.1 5600.3 5612.9 5190.2 5195.7 5199.4 5200.7 5201.5 5515.3 5637.1 5651.6 5654.0 5655.1 5288.5 5292.2 5311.8 5350.7 5357.3 5455.8 5456.9 5459.8 5462.0 5465.3 5404.2 5435.3 5448.2 5475.0 5497.8 5425.9 5443.5 5447.1 5449.2 5488.9 4192.4 4193.6 4194.4 4229.6 4233.2 3761.8 3815.5 3816.3 3817.0 3837.1 5193.2 5216.1 5222.4 5222.5 5238.3 5498.8 5513.7 5515.3 5515.6 5558.5 4982.9 5155.7 5210.8 5225.9 5293.3 4694.1 4699.4 4703.9 4721.2 4737.2 5776.3 5804.0 5809.4 5814.3 5824.6 5347.3 5486.3 5487.1 5551.2 5569.1 5770.4 5780.5 5783.7 5788.3 5802.8 5414.8 5415.6 5418.6 5422.9 5423.5 5408.3 5476.4 5507.0 5597.9 5598.2 5357.7 5369.5 5389.0 5395.5 5402.6 5373.4 5373.8 5374.4 5384.9 5421.8 5042.1 5309.4 5316.2 5371.5 5393.3 5397.1 5429.8 5430.8 5435.0 5494.2 5238.7 5282.7 5323.8 5328.3 5331.6 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | [#1] ext.html Cycles:180 Average:42644.38 Median:170962.77 stddev:68120.35 (39.8%) stddev-sans-first:68237.99 01:08:51 INFO - PROCESS | 24949 | Values: 511.3 517.2 520.0 564.8 588.4 28444.3 36503.5 36562.6 36583.3 36627.6 39433.6 40038.6 40054.4 40068.4 40118.4 7555.3 8573.1 8798.1 10181.1 10386.7 10313.1 10449.5 10451.8 10465.8 10471.8 10454.5 10544.9 10545.9 10546.9 10560.1 10348.4 10349.7 10394.4 10440.4 10449.9 10295.2 10349.7 10462.2 10670.3 10741.2 39538.6 39916.4 39938.6 39990.0 40027.0 3335.1 3405.7 3471.9 3882.6 3883.1 29981.4 30449.4 30612.0 30692.8 31942.9 3852.7 3864.0 3916.3 3967.3 3991.9 266541.7 267138.0 268632.0 268780.0 268849.0 57480.0 57953.7 57954.4 57977.4 58144.4 64255.0 64398.7 64500.4 64533.7 64551.0 14478.6 15042.5 15101.9 15113.9 16745.2 11903.5 11954.6 11984.2 11992.3 12008.7 19134.9 19167.5 19325.9 19358.4 19406.7 6533.5 7320.7 7719.4 7801.9 7827.2 955.4 959.2 964.5 970.9 1049.8 26133.5 26373.6 26382.0 26458.3 26515.0 1017.1 1026.5 1043.0 1043.2 1094.3 13823.4 14528.3 14644.6 14786.6 14947.3 306300.0 310382.0 310883.0 311127.0 311165.0 50837.0 51755.5 51782.2 51821.5 52075.7 1164.8 1316.7 1319.7 1334.0 1416.6 25256.9 25813.9 25953.9 26248.7 26352.3 39888.2 40140.2 40204.6 40232.6 40352.0 185770.0 186347.0 191545.0 194537.0 194549.0 27133.7 27412.0 30487.8 30515.5 31042.5 36629.0 36823.4 37192.8 37358.8 37471.0 31585.5 34154.5 34161.5 34374.0 34706.8 33582.8 33917.8 34018.5 34083.7 34600.7 33829.5 34470.3 34518.8 34565.0 34858.1 30544.8 31209.7 31476.7 31549.2 31570.0 23279.4 23860.3 24002.5 24055.3 24151.2 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | [#2] jquery.html Cycles:180 Average:23978.44 Median:411490.50 stddev:67874.05 (16.5%) stddev-sans-first:68041.25 01:08:51 INFO - PROCESS | 24949 | Values: 344.6 346.2 347.4 348.8 354.6 16421.6 16612.8 17115.7 18016.1 18184.5 14723.2 14986.2 15449.7 15491.0 15506.4 5329.0 5347.3 5459.1 5490.5 5491.3 5372.9 5404.6 5421.3 5450.9 5463.1 5342.1 5385.8 5388.2 5394.9 5405.4 5211.6 5285.6 5344.7 5369.1 5411.2 4727.4 4743.7 4748.4 4749.9 4750.0 19952.6 20995.5 21057.4 21268.5 21301.6 1999.6 2062.3 2063.7 2180.3 2870.2 8738.3 9205.3 10665.3 13021.7 13363.3 1815.2 1858.7 1933.1 1937.2 1966.1 60966.0 63016.4 63050.7 63587.7 64609.4 9514.9 9628.5 9832.6 9871.6 10034.3 12825.6 12827.6 12968.0 12969.4 12990.2 7421.9 7427.6 7476.7 7544.4 7742.5 7485.2 7617.5 7627.2 7706.8 7725.4 4231.7 4279.1 4286.4 4360.6 4365.8 1618.8 1662.6 1667.5 1669.4 1682.1 850.2 853.4 898.7 978.4 992.8 15434.5 16080.7 16625.7 16964.3 17196.5 908.7 913.9 941.0 952.6 955.8 9355.2 9776.7 9823.9 9862.2 9956.9 408909.0 414072.0 415042.0 415660.0 422281.1 48376.3 55267.0 56301.0 72414.0 74093.6 961.4 978.3 987.9 1000.9 1004.8 14729.5 14812.7 14859.4 14963.6 15447.5 30285.7 30437.5 31513.7 32870.0 33261.7 35112.0 36672.4 37865.8 38160.6 38744.8 7487.4 7643.8 7758.4 7853.2 7981.2 12506.4 12507.5 12539.4 12631.6 13104.2 10747.9 10844.2 10994.1 11018.9 11249.2 10603.6 10629.5 10726.9 10935.4 11130.7 10938.5 10940.0 11037.2 11119.3 11320.9 7454.7 7593.2 7627.5 7780.5 7985.7 9338.8 11048.9 11063.7 11081.9 11203.2 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | [#3] mootools.html Cycles:180 Average:5393.10 Median:6393.28 stddev:2856.48 (44.7%) stddev-sans-first:2848.06 01:08:51 INFO - PROCESS | 24949 | Values: 1316.4 1468.5 1485.2 1667.9 1817.1 7275.2 7357.6 7384.9 7393.1 7393.3 7347.9 7529.7 7531.1 7542.2 7552.9 1941.2 2000.4 2175.7 2218.3 2244.1 2253.5 2254.4 2254.5 2260.3 2264.6 2171.5 2188.7 2246.1 2247.5 2248.7 2205.5 2241.5 2246.7 2248.9 2280.3 2159.6 2161.8 2170.0 2172.9 2174.0 7773.5 7807.0 7847.1 7851.8 7861.7 4621.8 4698.8 4725.0 4727.1 4728.7 2845.5 2945.6 2957.2 2989.9 2994.9 900.6 902.7 905.7 949.3 951.0 10735.7 10761.2 10766.1 10772.7 10776.4 4207.1 4240.9 4323.6 4329.5 4341.6 9224.6 9255.5 9264.9 9265.9 9271.8 4850.3 4861.9 4862.3 4862.4 4866.6 3837.6 4180.2 4251.9 4256.4 4276.3 3506.6 3617.4 3642.1 3643.2 3670.7 1130.8 1174.9 1175.8 1175.9 1179.4 1332.8 1348.5 1355.4 1367.7 1373.2 7418.6 7551.7 7559.4 7562.9 7585.7 442.1 457.4 460.8 462.6 465.9 5459.4 5478.5 5499.7 5544.3 5581.6 9201.2 9325.3 9615.8 9617.3 9650.6 9430.0 9441.7 9481.5 9504.0 9506.6 7256.2 7323.5 7343.3 7351.2 7400.9 7013.9 7060.5 7063.1 7111.4 7116.9 8213.3 8332.4 8389.5 8405.2 8511.6 8621.7 8654.8 8661.4 8684.7 8824.9 6025.3 6245.3 6247.4 6548.1 6880.5 6853.4 7251.2 7351.9 7382.3 7439.1 6655.0 6706.6 6735.4 6786.2 6824.6 6618.6 6627.0 6668.9 6670.7 6723.1 6890.2 6943.3 6945.2 6955.4 7022.2 6516.4 6567.1 6568.7 6575.5 6575.8 6319.6 6390.4 6391.0 6395.6 6401.3 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | [#4] prototype.html Cycles:180 Average:5172.75 Median:5898.98 stddev:1590.21 (27.0%) stddev-sans-first:1552.21 01:08:51 INFO - PROCESS | 24949 | Values: 309.3 313.7 314.7 315.9 317.6 5738.8 5836.2 5860.2 5888.4 5909.6 5747.3 5768.9 5774.3 5776.3 5776.6 4263.1 4383.3 4384.7 4440.5 4443.0 4314.3 4379.8 4385.6 4413.7 4458.7 4402.6 4405.3 4405.7 4407.0 4411.5 4246.5 4297.8 4416.3 4426.5 4430.8 3782.0 3784.5 3787.1 3797.4 3798.9 5539.1 5544.5 5549.8 5550.4 5566.8 5039.5 5055.3 5056.3 5056.6 5062.8 6105.6 6119.9 6126.7 6135.4 6138.1 4151.6 4190.1 4191.5 4194.2 4195.4 6218.6 6350.7 6370.0 6381.9 6394.1 4298.4 4309.0 4315.8 4318.1 4324.4 4364.6 4368.6 4369.6 4372.0 4373.5 5066.5 5075.0 5082.5 5083.9 5091.2 6160.9 6173.8 6176.8 6186.6 6188.3 1492.9 1535.4 1539.8 1542.2 1554.6 1031.3 1045.0 1045.1 1053.6 1054.8 5782.5 5885.9 5940.3 5982.9 6049.0 6372.3 6395.0 6402.3 6408.7 6411.9 6043.0 6045.8 6045.8 6048.9 6050.0 3393.7 3447.9 3450.4 3451.5 3458.7 6606.1 6782.9 6791.6 6792.2 6798.4 6508.5 6532.9 6542.7 6545.9 6551.8 6781.5 6785.9 6787.3 6801.6 6801.8 6347.8 6383.5 6394.9 6398.8 6398.9 6240.3 6305.9 6359.6 6409.2 6414.9 6742.5 6789.6 6807.7 6818.2 6820.9 4394.3 4405.8 4407.4 4410.3 4416.1 6380.1 6384.4 6387.2 6392.5 6398.9 6174.2 6217.7 6226.4 6234.7 6240.6 6085.2 6173.8 6228.0 6233.9 6244.2 6108.0 6108.6 6133.8 6146.7 6151.0 6267.7 6298.6 6331.1 6331.5 6343.7 6099.7 6105.3 6107.2 6110.4 6112.2 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | [#5] yui.html Cycles:180 Average:13808.10 Median:44067.56 stddev:15916.74 (36.1%) stddev-sans-first:15931.04 01:08:51 INFO - PROCESS | 24949 | Values: 718.7 739.4 805.1 807.7 846.9 13446.9 13678.7 13784.8 13791.2 13849.4 12827.1 13336.5 13343.9 13372.7 13387.1 699.0 813.4 845.1 861.9 867.4 849.0 854.4 857.0 859.0 860.1 904.1 904.6 905.3 905.4 905.7 713.3 870.5 881.7 884.2 885.6 657.3 657.3 658.2 658.3 658.8 13877.7 13962.3 13994.2 14024.9 14038.8 13139.9 13487.7 13597.9 13667.6 13875.4 10478.4 10509.7 10571.4 10582.0 10676.3 3668.3 3673.6 3724.2 3810.6 4389.1 42603.0 43838.0 43971.1 44164.0 44361.9 10149.0 10318.7 10342.2 10413.1 10808.5 17896.6 17994.8 18010.5 18038.1 18089.1 7409.6 7502.0 7523.4 7586.5 7724.8 4221.8 4251.0 4259.9 4371.7 4435.3 3051.4 3053.9 3056.3 3071.5 3084.7 527.9 534.9 540.7 542.8 542.9 674.5 677.6 689.7 711.9 745.0 8150.7 8639.2 8651.2 8654.6 8736.1 615.7 668.4 700.2 705.9 716.2 4011.9 4072.2 4085.7 4133.3 4135.6 58085.0 59194.7 59245.0 59269.4 59631.0 48856.5 50133.2 50976.2 51620.7 51851.5 46942.0 47788.0 51315.0 51669.0 52014.7 7899.5 8204.5 8317.9 8379.2 8396.0 33043.7 33707.2 33849.7 34702.8 35113.8 41564.4 43662.3 44203.0 44581.0 44700.0 10695.3 10888.6 11001.9 11448.9 11746.5 9119.6 11488.7 12311.9 12529.5 12608.5 10269.4 10803.8 11144.0 11193.3 11708.2 10919.7 11088.4 11123.6 11161.2 11588.3 11045.2 11103.3 11128.9 11658.5 12157.1 9775.8 9990.8 10007.9 10215.5 10316.6 9122.4 9279.7 9468.8 9484.7 9576.3 01:08:51 INFO - PROCESS | 24949 | -------- Summary: end -------- 01:08:51 INFO - PROCESS | 24949 | 01:08:51 INFO - PROCESS | 24949 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:51 INFO - PROCESS | 24949 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:51 INFO - PROCESS | 24949 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:51 INFO - PROCESS | 24949 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:51 INFO - PROCESS | 24949 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:51 INFO - TEST-INFO | 24949: exit 0 01:08:51 INFO - TEST-OK | dromaeo_css | took 1112944ms 01:08:51 INFO - TEST-START | kraken 01:08:51 INFO - operating with platform_type : linux_ 01:08:51 INFO - Initialising browser for kraken test... 01:08:51 INFO - TEST-INFO | started process 25133 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHC3eKG/profile http://localhost:45580/getInfo.html) 01:08:55 INFO - PROCESS | 25133 | __metrics Screen width/height:1600/1200 01:08:55 INFO - PROCESS | 25133 | colorDepth:24 01:08:55 INFO - PROCESS | 25133 | Browser inner width/height: 1024/697 01:08:55 INFO - PROCESS | 25133 | __metrics 01:08:56 INFO - PROCESS | 25133 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:56 INFO - PROCESS | 25133 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:56 INFO - PROCESS | 25133 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:56 INFO - PROCESS | 25133 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:56 INFO - PROCESS | 25133 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:56 INFO - PROCESS | 25133 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:56 INFO - PROCESS | 25133 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:08:56 INFO - PROCESS | 25133 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 01:08:57 INFO - TEST-INFO | 25133: exit 0 01:08:57 INFO - Browser initialized. 01:08:57 INFO - Running cycle 1/1 for kraken test... 01:08:57 INFO - TEST-INFO | started process 25215 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHC3eKG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:09 INFO - PROCESS | 25215 | RSS: Main: 153358336 01:09:09 INFO - PROCESS | 25215 | 01:09:11 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45580/tests/kraken/driver.html?testName=audio-beat-detection) 01:09:12 INFO - PROCESS | 25215 | RSS: Main: 198197248 01:09:12 INFO - PROCESS | 25215 | 01:09:14 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45580/tests/kraken/driver.html?testName=audio-dft) 01:09:15 INFO - PROCESS | 25215 | RSS: Main: 186830848 01:09:15 INFO - PROCESS | 25215 | 01:09:18 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45580/tests/kraken/driver.html?testName=audio-fft) 01:09:19 INFO - PROCESS | 25215 | RSS: Main: 172724224 01:09:19 INFO - PROCESS | 25215 | 01:09:21 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45580/tests/kraken/driver.html?testName=audio-oscillator) 01:09:21 INFO - PROCESS | 25215 | RSS: Main: 172937216 01:09:21 INFO - PROCESS | 25215 | 01:09:23 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:09:24 INFO - PROCESS | 25215 | RSS: Main: 175104000 01:09:24 INFO - PROCESS | 25215 | 01:09:27 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45580/tests/kraken/driver.html?testName=imaging-darkroom) 01:09:28 INFO - PROCESS | 25215 | RSS: Main: 174313472 01:09:28 INFO - PROCESS | 25215 | 01:09:31 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45580/tests/kraken/driver.html?testName=imaging-desaturate) 01:09:31 INFO - PROCESS | 25215 | RSS: Main: 175513600 01:09:31 INFO - PROCESS | 25215 | 01:09:34 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45580/tests/kraken/driver.html?testName=json-parse-financial) 01:09:35 INFO - PROCESS | 25215 | RSS: Main: 175501312 01:09:35 INFO - PROCESS | 25215 | 01:09:36 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:09:37 INFO - PROCESS | 25215 | RSS: Main: 185745408 01:09:37 INFO - PROCESS | 25215 | 01:09:39 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:09:39 INFO - PROCESS | 25215 | RSS: Main: 183275520 01:09:39 INFO - PROCESS | 25215 | 01:09:41 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:09:42 INFO - PROCESS | 25215 | RSS: Main: 197079040 01:09:42 INFO - PROCESS | 25215 | 01:09:44 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:45 INFO - PROCESS | 25215 | RSS: Main: 201048064 01:09:45 INFO - PROCESS | 25215 | 01:09:48 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:48 INFO - PROCESS | 25215 | RSS: Main: 199684096 01:09:48 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:45580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45580/tests/kraken/driver.html?testName=ai-astar) 01:09:50 INFO - PROCESS | 25215 | RSS: Main: 259846144 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | __start_tp_report 01:09:50 INFO - PROCESS | 25215 | _x_x_mozilla_page_load 01:09:50 INFO - PROCESS | 25215 | _x_x_mozilla_page_load_details 01:09:50 INFO - PROCESS | 25215 | |i|pagename|runs| 01:09:50 INFO - PROCESS | 25215 | |0;ai-astar;110;111;107;112;110;112;101;110;111;112 01:09:50 INFO - PROCESS | 25215 | |1;audio-beat-detection;149;125;149;168;128;145;165;125;173;124 01:09:50 INFO - PROCESS | 25215 | |2;audio-dft;161;160;162;161;160;161;160;164;162;163 01:09:50 INFO - PROCESS | 25215 | |3;audio-fft;73;73;93;97;73;73;73;123;101;73 01:09:50 INFO - PROCESS | 25215 | |4;audio-oscillator;95;95;152;95;95;95;140;95;97;147 01:09:50 INFO - PROCESS | 25215 | |5;imaging-gaussian-blur;119;115;115;115;114;115;115;116;115;114 01:09:50 INFO - PROCESS | 25215 | |6;imaging-darkroom;145;146;146;146;145;145;144;146;145;145 01:09:50 INFO - PROCESS | 25215 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;96 01:09:50 INFO - PROCESS | 25215 | |8;json-parse-financial;57;55;57;55;56;56;54;66;55;54 01:09:50 INFO - PROCESS | 25215 | |9;json-stringify-tinderbox;67;67;66;67;67;68;67;68;67;68 01:09:50 INFO - PROCESS | 25215 | |10;stanford-crypto-aes;80;89;83;89;81;81;83;84;83;81 01:09:50 INFO - PROCESS | 25215 | |11;stanford-crypto-ccm;120;118;116;129;119;118;115;118;116;115 01:09:50 INFO - PROCESS | 25215 | |12;stanford-crypto-pbkdf2;150;138;157;147;152;137;149;147;147;157 01:09:50 INFO - PROCESS | 25215 | |13;stanford-crypto-sha256-iterative;69;68;68;69;68;69;69;77;68;67 01:09:50 INFO - PROCESS | 25215 | __end_tp_report 01:09:50 INFO - PROCESS | 25215 | __start_cc_report 01:09:50 INFO - PROCESS | 25215 | _x_x_mozilla_cycle_collect,1065 01:09:50 INFO - PROCESS | 25215 | __end_cc_report 01:09:50 INFO - PROCESS | 25215 | __startTimestamp1456736990537__endTimestamp 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | ------- Summary: start ------- 01:09:50 INFO - PROCESS | 25215 | Number of tests: 14 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.37 (3.0%) stddev-sans-first:3.57 01:09:50 INFO - PROCESS | 25215 | Values: 110.0 111.0 107.0 112.0 110.0 112.0 101.0 110.0 111.0 112.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:149.00 stddev:19.08 (12.8%) stddev-sans-first:20.18 01:09:50 INFO - PROCESS | 25215 | Values: 149.0 125.0 149.0 168.0 128.0 145.0 165.0 125.0 173.0 124.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.35 (0.8%) stddev-sans-first:1.42 01:09:50 INFO - PROCESS | 25215 | Values: 161.0 160.0 162.0 161.0 160.0 161.0 160.0 164.0 162.0 163.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#3] audio-fft Cycles:10 Average:85.20 Median:73.00 stddev:17.55 (24.0%) stddev-sans-first:18.05 01:09:50 INFO - PROCESS | 25215 | Values: 73.0 73.0 93.0 97.0 73.0 73.0 73.0 123.0 101.0 73.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:95.00 stddev:24.83 (26.1%) stddev-sans-first:25.69 01:09:50 INFO - PROCESS | 25215 | Values: 95.0 95.0 152.0 95.0 95.0 95.0 140.0 95.0 97.0 147.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 01:09:50 INFO - PROCESS | 25215 | Values: 119.0 115.0 115.0 115.0 114.0 115.0 115.0 116.0 115.0 114.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:09:50 INFO - PROCESS | 25215 | Values: 145.0 146.0 146.0 146.0 145.0 145.0 144.0 146.0 145.0 145.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:09:50 INFO - PROCESS | 25215 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:3.50 (6.3%) stddev-sans-first:3.71 01:09:50 INFO - PROCESS | 25215 | Values: 57.0 55.0 57.0 55.0 56.0 56.0 54.0 66.0 55.0 54.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 01:09:50 INFO - PROCESS | 25215 | Values: 67.0 67.0 66.0 67.0 67.0 68.0 67.0 68.0 67.0 68.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:3.20 (3.9%) stddev-sans-first:3.15 01:09:50 INFO - PROCESS | 25215 | Values: 80.0 89.0 83.0 89.0 81.0 81.0 83.0 84.0 83.0 81.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:118.00 stddev:4.09 (3.5%) stddev-sans-first:4.29 01:09:50 INFO - PROCESS | 25215 | Values: 120.0 118.0 116.0 129.0 119.0 118.0 115.0 118.0 116.0 115.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.50 stddev:6.72 (4.5%) stddev-sans-first:7.10 01:09:50 INFO - PROCESS | 25215 | Values: 150.0 138.0 157.0 147.0 152.0 137.0 149.0 147.0 147.0 157.0 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:2.82 (4.1%) stddev-sans-first:2.99 01:09:50 INFO - PROCESS | 25215 | Values: 69.0 68.0 68.0 69.0 68.0 69.0 69.0 77.0 68.0 67.0 01:09:50 INFO - PROCESS | 25215 | -------- Summary: end -------- 01:09:50 INFO - PROCESS | 25215 | 01:09:50 INFO - PROCESS | 25215 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:09:50 INFO - PROCESS | 25215 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:09:50 INFO - PROCESS | 25215 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:09:50 INFO - PROCESS | 25215 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:09:50 INFO - PROCESS | 25215 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 01:09:51 INFO - TEST-INFO | 25215: exit 0 01:09:51 INFO - TEST-OK | kraken | took 60093ms 01:09:51 INFO - SUITE-END | took 1173s 01:09:52 INFO - Completed test suite (00:19:33) 01:09:52 INFO - Working with test: dromaeo_css 01:09:52 INFO - Generating results file: dromaeo_css 01:09:52 INFO - Working with test: kraken 01:09:52 INFO - Generating results file: kraken 01:09:52 INFO - javascript benchmark 01:09:52 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:52 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 01:09:52 INFO - process_Request line: dromaeo_css 6779.99 graph.html#tests=[[72,63,35]] 01:09:52 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:09:52 INFO - process_Request line: kraken 1511.30 graph.html#tests=[[232,63,35]] 01:09:52 INFO - RETURN: dromaeo_css: 6779.99 01:09:52 INFO - RETURN: kraken: 1511.30 01:09:52 INFO - javascript benchmark 01:09:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3150.5116706910435, 3154.747620190384, 3185.2673885006448, 3186.8725250989946, 3219.726323262523, 5032.5219104185135, 5067.315912351832, 5075.79696812128, 5100.4134524529645, 5104.846854594359, 5164.173732202848, 5182.481751824816, 5190.195519694444, 5193.766280517376, 5209.557187639055, 4682.882927926795, 4717.127331443694, 4773.236282194849, 4773.618110551165, 4797.328374027639, 4583.495815460296, 4676.04141151065, 4733.431988161426, 4733.90532189356, 4853.538913803183, 4730.550597693231, 4743.715377077352, 4744.976275118637, 4779.880502987418, 4784.641151913603, 4735.502772208937, 4736.171170045262, 4759.690620109682, 4774.785134668949, 4789.473157952622, 4532.4787649420405, 4662.8368007119925, 4735.668503204777, 4741.075490279397, 4751.40607424072, 4978.402591688984, 4990.30135780991, 4992.176290911995, 5007.549320561167, 5040.218766091261, 5512.4211957744665, 5526.171074338841, 5526.861828454281, 5528.5024347808485, 5534.529564986981, 5446.2375267462585, 5526.115821468546, 5547.140193270049, 5600.327960644708, 5612.859678508029, 5190.169572868361, 5195.740212989335, 5199.376074871039, 5200.6619569727845, 5201.531862132389, 5515.25544051556, 5637.126245431965, 5651.632643878134, 5654.0, 5655.095184770417, 5288.524032837063, 5292.153255479105, 5311.840644780663, 5350.705711185844, 5357.276767636397, 5455.781768729206, 5456.91814622781, 5459.808906688247, 5462.0, 5465.262189604432, 5404.243405923174, 5435.2934118564335, 5448.182772584144, 5475.0418676731415, 5497.835064948058, 5425.945740542623, 5443.537299329522, 5447.101228297287, 5449.209864569615, 5488.862778430571, 4192.371144328315, 4193.643540299109, 4194.3708443733685, 4229.619334259932, 4233.1956928183545, 3761.830717617659, 3815.5039844819994, 3816.3321418751607, 3817.026658202141, 3837.13664425502, 5193.195054766442, 5216.113260745682, 5222.399424066205, 5222.477752224823, 5238.266642670029, 5498.80754173602, 5513.696746678971, 5515.310586176728, 5515.558755299567, 5558.527525160407, 4982.8754281143265, 5155.716435596079, 5210.843674689765, 5225.895482090337, 5293.258943747878, 4694.108119457293, 4699.412573428322, 4703.858884233478, 4721.15019296523, 4737.2183589708, 5776.3068431787615, 5803.970980145073, 5809.3609702932645, 5814.30228372598, 5824.5631577631, 5347.304850369427, 5486.341639003345, 5487.067198576331, 5551.22282880389, 5569.136783798518, 5770.422957704196, 5780.450857168562, 5783.710814459176, 5788.305403351625, 5802.82591522255, 5414.75633596497, 5415.6479828811, 5418.620696551204, 5422.864428389322, 5423.538999185113, 5408.296921400193, 5476.370217424887, 5507.0, 5597.860053498533, 5598.1602759586385, 5357.732113394392, 5369.48989845964, 5389.0299746046085, 5395.4604539545735, 5402.621816472966, 5373.408925018167, 5373.838784836461, 5374.435684253253, 5384.865378365572, 5421.810236641699, 5042.117629414911, 5309.38942021657, 5316.175992721134, 5371.516563509303, 5393.325834270716, 5397.055515284888, 5429.7556609953435, 5430.8099216527235, 5434.972825135849, 5494.230807687007, 5238.738063096754, 5282.735863206901, 5323.813666521653, 5328.280682107866, 5331.573474122139], "unit": "score", "name": "dojo.html", "value": 5090.789170087774}, {"lowerIsBetter": false, "replicates": [511.3148381169232, 517.1647788821055, 520.0457161109364, 564.8223454098205, 588.3528119069025, 28444.288892777666, 36503.45244821323, 36562.634373656256, 36583.26833463329, 36627.63372366276, 39433.60566394335, 40038.59961400385, 40054.39918401226, 40068.398974015414, 40118.39822402659, 7555.282248186413, 8573.142685731424, 8798.076201998794, 10181.134603558707, 10386.740331491697, 10313.123384512326, 10449.529771160278, 10451.790964180711, 10465.79068418635, 10471.842922356132, 10454.477276136162, 10544.894551054467, 10545.947270263676, 10546.894531054706, 10560.102391296748, 10348.379097254114, 10349.741256468611, 10394.428306443142, 10440.425776582322, 10449.947750261237, 10295.176385889112, 10349.741256468573, 10462.215333849916, 10670.346096355077, 10741.19441041925, 39538.60461395407, 39916.40125398121, 39938.60061399378, 39990.00024999369, 40027.0, 3335.099523128766, 3405.744569157323, 3471.861125554975, 3882.592327805568, 3883.0680636647285, 29981.400371992655, 30449.391012179854, 30612.0, 30692.846535767403, 31942.88199913015, 3852.653261206477, 3863.98068009661, 3916.255911376858, 3967.2858885400615, 3991.940120898189, 266541.6672916642, 267138.0, 268632.0, 268780.0, 268849.0, 57480.0, 57953.710231448575, 57954.42045579575, 57977.42022579804, 58144.4185558139, 64255.0, 64398.67800661061, 64500.354996450376, 64533.67733161304, 64551.0, 14478.638034049023, 15042.548723538312, 15101.924490377478, 15113.924430377778, 16745.16274186286, 11903.523859045714, 11954.581589644495, 11984.221025633306, 11992.280463172237, 12008.699782505508, 19134.904325478285, 19167.52081197953, 19325.903370483058, 19358.4192474226, 19406.70889936652, 6533.542652014314, 7320.67056982437, 7719.399624391615, 7801.882971755428, 7827.217278272127, 955.350361754014, 959.1799011844912, 964.4791812421214, 970.854371844229, 1049.8320268757116, 26133.477330453283, 26373.604395934075, 26382.0, 26458.33854153623, 26515.0, 1017.0846238385365, 1026.4662375564665, 1043.0, 1043.186314674555, 1094.3379255550278, 13823.377947992365, 14528.346224419927, 14644.560663180122, 14786.63033424173, 14947.252637368088, 306300.0, 310382.0, 310883.0, 311127.0, 311165.0, 50837.0, 51755.48244517582, 51782.223266650275, 51821.48178518242, 52075.739621301655, 1164.831099490586, 1316.7234880675167, 1319.663485811112, 1334.0194956706812, 1416.6458385403648, 25256.873715631304, 25813.870930645226, 25953.870230648725, 26248.73751262463, 26352.34119147037, 39888.20223595454, 40140.1971960565, 40204.597954020086, 40232.59767402289, 40352.0, 185770.0, 186347.0, 191545.0, 194537.0, 194549.0, 27133.72866271312, 27412.0, 30487.84756076294, 30515.54226686557, 31042.53436198504, 36629.0, 36823.44764828476, 37192.81403593073, 37358.813205933795, 37471.0, 31585.52621710722, 34154.48768268428, 34161.48757768586, 34374.0, 34706.82646586751, 33582.832085839415, 33917.83041084779, 34018.489722653685, 34083.659163409044, 34600.65399346075, 33829.492557611164, 34470.31059378848, 34518.82740586281, 34565.0, 34858.12854678552, 30544.847275763477, 31209.687903120677, 31476.685233147375, 31549.211269718442, 31570.0, 23279.41801454977, 23860.284191474282, 24002.51994960126, 24055.278341649777, 24151.15470958508], "unit": "score", "name": "ext.html", "value": 18121.578197239207}, {"lowerIsBetter": false, "replicates": [344.6088689337601, 346.23827579325484, 347.3833944748073, 348.7837540724751, 354.59398988158546, 16421.589460263498, 16612.750808737877, 17115.657686846273, 18016.09919504026, 18184.454466365998, 14723.190224537646, 14986.175760333177, 15449.69100617987, 15491.0, 15506.379744810194, 5328.960852633738, 5347.331583552056, 5459.071957767169, 5490.478404551562, 5491.341039075317, 5372.91940620889, 5404.621676482648, 5421.322334708161, 5450.863728406782, 5463.071277882749, 5342.118550439173, 5385.78456861725, 5388.191771234327, 5394.865128371783, 5405.405405405402, 5211.635185537014, 5285.550728188108, 5344.652597581165, 5369.087255166631, 5411.242426060335, 4727.385439892826, 4743.695483741964, 4748.3589715388325, 4749.857504274877, 4749.9762501187615, 19952.603317767764, 20995.475113122142, 21057.368278951657, 21268.468288292763, 21301.573968520544, 1999.6400647883374, 2062.2988184017354, 2063.669812829955, 2180.269609680743, 2870.1819981305434, 8738.344624153151, 9205.309601779893, 10665.346871234971, 13021.674458138528, 13363.33183340829, 1815.2376002079159, 1858.6654402207598, 1933.1204302042536, 1937.2444746548858, 1966.1349006437265, 60966.0, 63016.369836301965, 63050.68474657597, 63587.68206158986, 64609.35390646127, 9514.857277140849, 9628.518574071408, 9832.606695732233, 9871.555779989918, 10034.297599168134, 12825.551105711254, 12827.551035713705, 12968.0, 12969.351532423341, 12990.155639883378, 7421.851562968711, 7427.591482468516, 7476.738314158978, 7544.358729508053, 7742.496737712031, 7485.214052524516, 7617.5048621839405, 7627.237276272328, 7706.807329816687, 7725.381969442431, 4231.682623803227, 4279.101388708406, 4286.37847512109, 4360.629346505519, 4365.825366985348, 1618.789557357536, 1662.642531855657, 1667.466410748573, 1669.4490818030022, 1682.1168886334528, 850.1880703927734, 853.4068822168533, 898.725888603969, 978.3689520259393, 992.7567745902301, 15434.536963891102, 16080.678386432206, 16625.6674866502, 16964.321427143022, 17196.53829424513, 908.6683360573476, 913.9268858491305, 940.9858852117223, 952.5808644196532, 955.8470644696815, 9355.204807591295, 9776.657816976372, 9823.852642210373, 9862.211023118134, 9956.850647240297, 408909.0, 414072.0, 415042.0, 415660.0, 422281.10875564633, 48376.27435588469, 55267.0, 56301.0, 72414.0, 74093.62953185308, 961.403929563675, 978.3347323819728, 987.8567607696843, 1000.9249306302056, 1004.7889943111882, 14729.484468043567, 14812.703745925237, 14859.405623775361, 14963.551093467213, 15447.5365739028, 30285.697143028287, 30437.543436848024, 31513.684863151993, 32870.0, 33261.667383325854, 35112.0, 36672.44991325079, 37865.81067094647, 38160.618393815705, 38744.80627596844, 7487.438442116754, 7643.847123057397, 7758.379329653501, 7853.175416581405, 7981.241782030698, 12506.374681266083, 12507.499700011898, 12539.435725392197, 12631.557895473614, 13104.2137471752, 10747.946260268649, 10844.186685998424, 10994.120470362512, 11018.944905275423, 11249.156313276373, 10603.575856965635, 10629.468526573795, 10726.87367826367, 10935.418361084336, 11130.666080017612, 10938.507767150339, 10940.0, 11037.172212084286, 11119.332840029625, 11320.943395282971, 7454.664540095817, 7593.202713715202, 7627.54234745917, 7780.455368124403, 7985.683038377503, 9338.813223735351, 11048.944755276172, 11063.668089957315, 11081.889181108085, 11203.21577489568], "unit": "score", "name": "jquery.html", "value": 8192.206765202927}, {"lowerIsBetter": false, "replicates": [1316.447092221267, 1468.5080498033158, 1485.1534625263598, 1667.8582320502758, 1817.0551313317067, 7275.163356214037, 7357.632118394085, 7384.889226661598, 7393.07586551681, 7393.297636724503, 7347.934549490334, 7529.661165247563, 7531.133919599248, 7542.208068152847, 7552.8867066994035, 1941.1652989214633, 2000.4298774849171, 2175.6954026436233, 2218.290147152916, 2244.079927229836, 2253.5154941687533, 2254.357508110189, 2254.549090181962, 2260.2541161416775, 2264.558411109826, 2171.4896999205175, 2188.671699245118, 2246.1240116354634, 2247.494313779403, 2248.696425982496, 2205.4817117977263, 2241.529278851435, 2246.7191601049867, 2248.853824501402, 2280.315905228425, 2159.5572907553915, 2161.8162456191244, 2169.9891500542553, 2172.902219400115, 2173.9891300543554, 7773.494722843054, 7806.960965195194, 7847.058352997619, 7851.842963140705, 7861.68553257869, 4621.768911554409, 4698.788554515055, 4724.976375118103, 4727.149113159629, 4728.692634978715, 2845.4735873863197, 2945.617069780936, 2957.216337670519, 2989.865456054483, 2994.9101526954228, 900.6442455230213, 902.6524787956619, 905.7463910105181, 949.3449519831295, 950.9714708558685, 10735.731606709895, 10761.192910531663, 10766.084882784973, 10772.676819695422, 10776.353418794897, 4207.116505533811, 4240.851570195028, 4323.610875021263, 4329.458817647794, 4341.60925516705, 9224.631014759469, 9255.490947997925, 9264.907350926405, 9265.861012084824, 9271.814563708824, 4850.296706977469, 4861.927071093936, 4862.270659401047, 4862.41651001882, 4866.562009419098, 3837.5970523094675, 4180.226658068267, 4251.893702657459, 4256.361545768098, 4276.294411422081, 3506.5967413747235, 3617.385044542434, 3642.0712718256673, 3643.1620727232885, 3670.7430479866152, 1130.8360287758228, 1174.8825117488354, 1175.7707247086737, 1175.9235649682744, 1179.445660539545, 1332.7667658159783, 1348.4875747215995, 1355.3833005982253, 1367.7469668111232, 1373.2378529915793, 7418.554886706707, 7551.697932082655, 7559.395248380117, 7562.886556701654, 7585.734499292498, 442.10253186031764, 457.38253357966477, 460.75579942629787, 462.6067842333989, 465.8858579648008, 5459.3994660587305, 5478.506934375846, 5499.697516636544, 5544.3346798384455, 5581.609287349846, 9201.217896478875, 9325.253979681609, 9615.807683846284, 9617.326787124974, 9650.613975441043, 9430.0, 9441.669541566012, 9481.525923703788, 9503.952480237554, 9506.572204250826, 7256.201817800038, 7323.450741194325, 7343.265673432721, 7351.191368949411, 7400.925990740024, 7013.894791578028, 7060.470464715269, 7063.081799366049, 7111.431085513043, 7116.928830711627, 8213.301869341172, 8332.416730828783, 8389.454685445426, 8405.159484051546, 8511.574421278787, 8621.655133794578, 8654.82690346202, 8661.393702440768, 8684.652613895374, 8824.86762698573, 6025.276966764016, 6245.28179259391, 6247.406496382836, 6548.0832683423405, 6880.518363714492, 6853.383195512428, 7251.166115896739, 7351.889721654286, 7382.2617738225745, 7439.144498382755, 6655.001749737385, 6706.597604143767, 6735.360140786617, 6786.185657721105, 6824.624645644537, 6618.63597502142, 6626.966865165643, 6668.899966500603, 6670.666466676744, 6723.058771771858, 6890.20762612306, 6943.305669433016, 6945.201301850352, 6955.374016338554, 7022.227554969051, 6516.446102081187, 6567.146270984741, 6568.671566421755, 6575.539712220098, 6575.835604109936, 6319.557630965788, 6390.392912673288, 6390.977443609, 6395.584287021329, 6401.29585745577], "unit": "score", "name": "mootools.html", "value": 4335.185287808846}, {"lowerIsBetter": false, "replicates": [309.32258354204293, 313.68317998821186, 314.6805991918205, 315.8862809388621, 317.5934803451582, 5738.7991420300295, 5836.182934389183, 5860.208871802316, 5888.35228124907, 5909.615874968124, 5747.2528571285675, 5768.913466298009, 5774.307083150017, 5776.335721392041, 5776.566757493184, 4263.062126332202, 4383.298672212431, 4384.693071484998, 4440.533743956878, 4443.0, 4314.3097104463295, 4379.781010949456, 4385.583369579885, 4413.668974826901, 4458.71018383804, 4402.647788176954, 4405.2511073117485, 4405.7356558606425, 4406.955930440687, 4411.536788637195, 4246.4691913510815, 4297.828086876521, 4416.293393057112, 4426.490953540336, 4430.800613972363, 3782.0355809268463, 3784.4701741756176, 3787.1478917243676, 3797.39241721326, 3798.948567773399, 5539.113741801333, 5544.528715059225, 5549.77800887964, 5550.4449555044575, 5566.777328906839, 5039.538533825186, 5055.34280543527, 5056.292119103328, 5056.570191533724, 5062.82280120194, 6105.603135796159, 6119.908201376983, 6126.663033533154, 6135.3864613538735, 6138.0792881067755, 4151.584841515854, 4190.120074784269, 4191.455110835603, 4194.224068547329, 4195.370694395865, 6218.595791273553, 6350.745970161188, 6370.0, 6381.904271435932, 6394.072859435356, 4298.376735373354, 4309.0, 4315.762633055149, 4318.050028993616, 4324.35134729793, 4364.607185353333, 4368.628666563314, 4369.60673539383, 4372.038151606642, 4373.453318335208, 5066.46802085783, 5074.985002999415, 5082.542571168613, 5083.8983220335385, 5091.1854103343285, 6160.907586386208, 6173.783917562953, 6176.752929882754, 6186.628802271878, 6188.2883468400805, 1492.8731057860205, 1535.3935195597676, 1539.8383169767012, 1542.2365928865058, 1554.5880341709455, 1031.3244824639723, 1044.9634262800766, 1045.0646671229208, 1053.5733028123623, 1054.8101341758404, 5782.479576838105, 5885.852853678607, 5940.257467816523, 5982.9401705983255, 6048.969755151196, 6372.2671892732005, 6394.9680251599375, 6402.327755585597, 6408.679566021773, 6411.903821442682, 6042.969785151046, 6045.78839740607, 6045.8488537786025, 6048.909266361008, 6049.969750151221, 3393.745469089828, 3447.87932422364, 3450.413429716954, 3451.4995325677637, 3458.706009989179, 6606.141201643755, 6782.898256526156, 6791.626460544619, 6792.184937807396, 6798.354156355138, 6508.479321654351, 6532.934670653328, 6542.738290468423, 6545.9018114728315, 6551.80344589663, 6781.491388145811, 6785.8642827143185, 6787.287334829772, 6801.557898736566, 6801.775680377579, 6347.809565713036, 6383.457406120346, 6394.87210255783, 6398.776042838478, 6398.904016439664, 6240.251169859646, 6305.873882522415, 6359.55483116196, 6409.230892292955, 6414.871702565829, 6742.460603151638, 6789.626570538668, 6807.693653785493, 6818.215905170969, 6820.897686534607, 4394.340848872695, 4405.80173892182, 4407.449068866392, 4410.29435290352, 4416.116776644748, 6380.074889141141, 6384.361563843579, 6387.233531976192, 6392.456641185551, 6398.872022559616, 6174.197354343906, 6217.689115544295, 6226.439620434183, 6234.659548197159, 6240.563160578716, 6085.178500902499, 6173.84565385869, 6227.96886015567, 6233.906491402542, 6244.1570387997035, 6108.0, 6108.5723999319625, 6133.815985520441, 6146.661933593517, 6151.0, 6267.655278959701, 6298.590591611531, 6331.081993110881, 6331.493480521455, 6343.746250149942, 6099.725512352044, 6105.267367915879, 6107.175531303217, 6110.358412366815, 6112.235970503687], "unit": "score", "name": "prototype.html", "value": 4651.097038684501}, {"lowerIsBetter": false, "replicates": [718.7484380466834, 739.412167326975, 805.1169656036141, 807.7495976247363, 846.8814365988762, 13446.932765336172, 13678.658033549142, 13784.793228101587, 13791.241481718527, 13849.376778044987, 12827.102102852805, 13336.466541338335, 13343.866561334384, 13372.665683357922, 13387.129836560616, 698.9755358562452, 813.446856137826, 845.1337379186322, 861.9482831030127, 867.3841572483544, 849.049065047148, 854.3677678517914, 857.0443954990172, 858.9699360522383, 860.1484530314974, 904.145582424609, 904.606496174163, 905.3436258712413, 905.3571963905634, 905.6920646980026, 713.2582114600809, 870.503812826689, 881.6825942660637, 884.1909652667802, 885.6368888755579, 657.3065415986133, 657.3360905485446, 658.1805651963289, 658.3350815676154, 658.7595527632427, 13877.722445551033, 13962.301884905815, 13994.16035037901, 14024.859751402457, 14038.789418158736, 13139.86860131396, 13487.66280842977, 13597.932010339984, 13667.589972300846, 13875.444982200801, 10478.423686697228, 10509.684709458652, 10571.36571805694, 10582.047615714622, 10676.252662313564, 3668.284684486526, 3673.6326367363317, 3724.2179142380132, 3810.599887011879, 4389.144116897174, 42603.0, 43838.0, 43971.12057758827, 44164.0, 44361.89095272612, 10149.0, 10318.690439286684, 10342.172626189888, 10413.11488523484, 10808.459577021118, 17896.55258618545, 17994.820051799576, 18010.459686209433, 18038.098095095193, 18089.095545222684, 7409.592472413961, 7501.962490187623, 7523.435742319348, 7586.468947173756, 7724.7682569523, 4221.83994090619, 4250.978745106255, 4259.914801704011, 4371.672124590605, 4435.26818075014, 3051.4354844353866, 3053.908382748521, 3056.251218451449, 3071.508558630608, 3084.6606873243927, 527.8733104054999, 534.9170878513837, 540.7107197649239, 542.8317221661298, 542.8941356435536, 674.4671709349657, 677.6494902724422, 689.6586189836063, 711.9466040047017, 745.0016977250402, 8150.673973041131, 8639.16115796664, 8651.221390074923, 8654.610542525601, 8736.08271131522, 615.7321565119188, 668.3884245914934, 700.166801506206, 705.9152901651835, 716.1907045039072, 4011.91976160481, 4072.226277007359, 4085.7140000200293, 4133.276676581646, 4135.60711732385, 58085.0, 59194.704026479594, 59245.0, 59269.40730592639, 59631.0, 48856.511434885906, 50133.24800128001, 50976.23535646968, 51620.74189629028, 51851.48148518542, 46942.0, 47788.0, 51315.0, 51668.96662066738, 52014.739926300885, 7899.526028438312, 8204.507729536246, 8317.916820831715, 8379.162083791573, 8395.99248090233, 33043.66956330406, 33707.15732106717, 33849.661503384654, 34702.82648586842, 35113.824430877685, 41564.37653435261, 43662.34506482469, 44202.97059232957, 44581.0, 44700.0, 10695.340928244867, 10888.61889833852, 11001.944990274997, 11448.885511145116, 11746.471408786454, 9119.635214591342, 11488.712782180512, 12311.876881231074, 12529.49882004746, 12608.49566017349, 10269.383836969806, 10803.837942430713, 11144.0, 11193.27243729155, 11708.180427370002, 10919.727006824574, 11088.445577721242, 11123.610673626385, 11161.162912781412, 11588.304701717923, 11045.171612128961, 11103.278286911647, 11128.944355278172, 11658.533658653898, 12157.1489995703, 9775.804483910424, 9990.753005273169, 10007.899921000697, 10215.489225538842, 10316.587336506456, 9122.361434699507, 9279.72160835176, 9468.810623787624, 9484.715458536255, 9576.281778866753], "unit": "score", "name": "yui.html", "value": 6373.664520871671}], "name": "dromaeo_css", "value": 6779.989005047983}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 112.0, 110.0, 112.0, 101.0, 110.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 149.0, 168.0, 128.0, 145.0, 165.0, 125.0, 173.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 162.0, 161.0, 160.0, 161.0, 160.0, 164.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 93.0, 97.0, 73.0, 73.0, 73.0, 123.0, 101.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 152.0, 95.0, 95.0, 95.0, 140.0, 95.0, 97.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 114.0, 115.0, 115.0, 116.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 145.0, 144.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [57.0, 55.0, 57.0, 55.0, 56.0, 56.0, 54.0, 66.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [80.0, 89.0, 83.0, 89.0, 81.0, 81.0, 83.0, 84.0, 83.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 116.0, 129.0, 119.0, 118.0, 115.0, 118.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 157.0, 147.0, 152.0, 137.0, 149.0, 147.0, 147.0, 157.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 77.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1511.3000000000002}]} 01:09:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1511.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6779.99"}}} 01:09:52 INFO - Return code: 0 01:09:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:09:52 INFO - # TBPL SUCCESS # 01:09:52 INFO - Running post-action listener: _resource_record_post_action 01:09:52 INFO - Running post-run listener: _resource_record_post_run 01:09:53 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 20480; Write bytes: 539209728; Read time: 32; Write time: 699572 01:09:53 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 240820224; Read time: 0; Write time: 412172 01:09:53 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 20480; Write bytes: 298389504; Read time: 32; Write time: 287400 01:09:53 INFO - Running post-run listener: _upload_blobber_files 01:09:53 INFO - Blob upload gear active. 01:09:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:09:53 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 01:09:53 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'] 01:09:53 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 01:09:53 INFO - (blobuploader) - INFO - Open directory for files ... 01:09:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:09:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:09:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:09:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:09:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:09:54 INFO - (blobuploader) - INFO - Done attempting. 01:09:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 01:09:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:09:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:09:55 INFO - (blobuploader) - INFO - Done attempting. 01:09:55 INFO - (blobuploader) - INFO - Iteration through files over. 01:09:55 INFO - Return code: 0 01:09:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:09:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:09:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7e6ee28a9076def2ce95f7d03367504abbb7d49c9630aa5ebba4c3d3069c1244d75833a87d3e962ef6c7c7a62822f29c23f0fb1590acb54a26788036d8e1b44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/650711f4cf14b8aca6b1b2921c555e3dafb2f48769cdd5acf4be63fc45cf27ecc469d245f1a7743442d5822dac1adc7338ea185b1428a238ec608566c4a5a41b"} 01:09:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:09:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:09:55 INFO - Contents: 01:09:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7e6ee28a9076def2ce95f7d03367504abbb7d49c9630aa5ebba4c3d3069c1244d75833a87d3e962ef6c7c7a62822f29c23f0fb1590acb54a26788036d8e1b44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/650711f4cf14b8aca6b1b2921c555e3dafb2f48769cdd5acf4be63fc45cf27ecc469d245f1a7743442d5822dac1adc7338ea185b1428a238ec608566c4a5a41b"} 01:09:55 INFO - Running post-run listener: copy_logs_to_upload_dir 01:09:55 INFO - Copying logs to upload dir... 01:09:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:09:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.495046 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-29 01:09:55.184179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 01:09:55.188097) ========= 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7e6ee28a9076def2ce95f7d03367504abbb7d49c9630aa5ebba4c3d3069c1244d75833a87d3e962ef6c7c7a62822f29c23f0fb1590acb54a26788036d8e1b44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/650711f4cf14b8aca6b1b2921c555e3dafb2f48769cdd5acf4be63fc45cf27ecc469d245f1a7743442d5822dac1adc7338ea185b1428a238ec608566c4a5a41b"} build_url:https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011538 build_url: 'https://queue.taskcluster.net/v1/task/FL5-_dQHTqGhUpngwBY9UQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a7e6ee28a9076def2ce95f7d03367504abbb7d49c9630aa5ebba4c3d3069c1244d75833a87d3e962ef6c7c7a62822f29c23f0fb1590acb54a26788036d8e1b44", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/650711f4cf14b8aca6b1b2921c555e3dafb2f48769cdd5acf4be63fc45cf27ecc469d245f1a7743442d5822dac1adc7338ea185b1428a238ec608566c4a5a41b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-29 01:09:55.215525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 01:09:55.215874) ========= 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=aa52b8aba932b19cc50b5275000001de-1456733663.288156-2079547140 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 01:09:55.300772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 01:09:55.301488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 01:09:55.302159) ========= ========= Total master_lag: 0.30 =========