builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1455700078.79 results: success (0) buildid: 20160216200457 builduid: 820839bcae474121bd03633c0324a9ae revision: 1b3ab4045d79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.792105) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.792486) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.792766) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.826500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.826775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.855879) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.856130) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012134 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.910624) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.910883) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.911242) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:58.911517) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-17 01:07:59-- 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% 215M=0s 2016-02-17 01:07:59 (215 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101530 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.031718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.031988) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.073800 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.118249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.118593) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1b3ab4045d79 --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 1b3ab4045d79 --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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-17 01:07:59,320 Setting DEBUG logging. 2016-02-17 01:07:59,320 attempt 1/10 2016-02-17 01:07:59,320 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1b3ab4045d79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-17 01:07:59,603 unpacking tar archive at: mozilla-inbound-1b3ab4045d79/testing/mozharness/ program finished with exit code 0 elapsedTime=0.588632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.720138) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.720464) ========= echo 1b3ab4045d79 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1b3ab4045d79'] 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1b3ab4045d79 program finished with exit code 0 elapsedTime=0.004613 script_repo_revision: '1b3ab4045d79' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.771411) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.771680) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-17 01:07:59.781554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-17 01:07:59.781827) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:08:00 INFO - MultiFileLogger online at 20160217 01:08:00 in /builds/slave/test-pgo 01:08:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 01:08:00 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:08:00 INFO - {'append_to_log': False, 01:08:00 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:08:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:08:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:08:00 INFO - 'branch': 'Mozilla-Inbound', 01:08:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:08:00 INFO - 'config_files': ('talos/linux_config.py',), 01:08:00 INFO - 'default_actions': ('clobber', 01:08:00 INFO - 'read-buildbot-config', 01:08:00 INFO - 'download-and-extract', 01:08:00 INFO - 'populate-webroot', 01:08:00 INFO - 'create-virtualenv', 01:08:00 INFO - 'install', 01:08:00 INFO - 'run-tests'), 01:08:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:08:00 INFO - 'download_minidump_stackwalk': True, 01:08:00 INFO - 'download_symbols': 'ondemand', 01:08:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:08:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:08:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:08:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:08:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:08:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:08:00 INFO - 'installer_path': 'installer.exe', 01:08:00 INFO - 'log_level': 'info', 01:08:00 INFO - 'log_name': 'talos', 01:08:00 INFO - 'log_to_console': True, 01:08:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:08:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:08:00 INFO - 'opt_config_files': (), 01:08:00 INFO - 'pip_index': False, 01:08:00 INFO - 'sps_profile': False, 01:08:00 INFO - 'sps_profile_interval': 0, 01:08:00 INFO - 'suite': 'dromaeojs-e10s', 01:08:00 INFO - 'system_bits': '32', 01:08:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:08:00 INFO - 'title': 'talos-linux64-ix-005', 01:08:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:08:00 INFO - 'use_talos_json': True, 01:08:00 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:08:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:08:00 INFO - 'work_dir': 'build'} 01:08:00 INFO - ##### 01:08:00 INFO - ##### Running clobber step. 01:08:00 INFO - ##### 01:08:00 INFO - Running pre-action listener: _resource_record_pre_action 01:08:00 INFO - Running main action method: clobber 01:08:00 INFO - rmtree: /builds/slave/test-pgo/build 01:08:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:08:01 INFO - Running post-action listener: _resource_record_post_action 01:08:01 INFO - ##### 01:08:01 INFO - ##### Running read-buildbot-config step. 01:08:01 INFO - ##### 01:08:01 INFO - Running pre-action listener: _resource_record_pre_action 01:08:01 INFO - Running main action method: read_buildbot_config 01:08:01 INFO - Using buildbot properties: 01:08:01 INFO - { 01:08:01 INFO - "project": "", 01:08:01 INFO - "product": "firefox", 01:08:01 INFO - "script_repo_revision": "production", 01:08:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 01:08:01 INFO - "repository": "", 01:08:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 01:08:01 INFO - "buildid": "20160216200457", 01:08:01 INFO - "pgo_build": "True", 01:08:01 INFO - "basedir": "/builds/slave/test-pgo", 01:08:01 INFO - "buildnumber": 328, 01:08:01 INFO - "slavename": "talos-linux64-ix-005", 01:08:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:08:01 INFO - "platform": "ubuntu64_hw", 01:08:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:08:01 INFO - "branch": "mozilla-inbound", 01:08:01 INFO - "repo_path": "integration/mozilla-inbound", 01:08:01 INFO - "revision": "1b3ab4045d79", 01:08:01 INFO - "stage_platform": "linux64-pgo", 01:08:01 INFO - "builduid": "820839bcae474121bd03633c0324a9ae", 01:08:01 INFO - "slavebuilddir": "test" 01:08:01 INFO - } 01:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 01:08:01 INFO - Running post-action listener: _resource_record_post_action 01:08:01 INFO - ##### 01:08:01 INFO - ##### Running download-and-extract step. 01:08:01 INFO - ##### 01:08:01 INFO - Running pre-action listener: _resource_record_pre_action 01:08:01 INFO - Running main action method: download_and_extract 01:08:01 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:08:01 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')]} 01:08:01 INFO - https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:08:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/test_packages.json 01:08:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/test_packages.json 01:08:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:08:02 INFO - Downloaded 1448 bytes. 01:08:02 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:08:02 INFO - Using the following test package requirements: 01:08:02 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:08:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:08:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'jsshell-linux-x86_64.zip'], 01:08:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:08:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:08:02 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:08:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:08:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 01:08:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 01:08:02 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:08:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:02 INFO - https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:03 INFO - Downloaded 23346177 bytes. 01:08:03 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'] 01:08:03 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 01:08:04 INFO - Return code: 0 01:08:04 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 01:08:04 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')]} 01:08:04 INFO - https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:08:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:08:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 01:08:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:05 INFO - Downloaded 23346177 bytes. 01:08:05 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'] 01:08:05 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 01:08:07 INFO - Return code: 0 01:08:07 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')]} 01:08:07 INFO - https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:08:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 01:08:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:08 INFO - Downloaded 10707071 bytes. 01:08:08 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'] 01:08:08 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 01:08:08 INFO - Return code: 0 01:08:08 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')]} 01:08:08 INFO - https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:08:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:08:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:08:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PhM8pgxZQsegBzJm2ikTDQ/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 01:08:10 INFO - Downloaded 56484897 bytes. 01:08:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:08:10 INFO - mkdir: /builds/slave/test-pgo/properties 01:08:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 01:08:10 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 01:08:10 INFO - Contents: 01:08:10 INFO - build_url:https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 01:08:11 INFO - Running post-action listener: _resource_record_post_action 01:08:11 INFO - Running post-action listener: set_extra_try_arguments 01:08:11 INFO - ##### 01:08:11 INFO - ##### Running populate-webroot step. 01:08:11 INFO - ##### 01:08:11 INFO - Running pre-action listener: _resource_record_pre_action 01:08:11 INFO - Running main action method: populate_webroot 01:08:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:08:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:08:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:08:11 INFO - '--tppagecycles', 01:08:11 INFO - '7'], 01:08:11 INFO - 'tests': ['tsvgm']}}, 01:08:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:08:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:08:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:08:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:08:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:08:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'tests': ['damp', 'tps']}, 01:08:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['damp', 'tps']}, 01:08:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:08:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:08:11 INFO - 'other': {'tests': ['a11yr', 01:08:11 INFO - 'ts_paint', 01:08:11 INFO - 'tpaint', 01:08:11 INFO - 'sessionrestore', 01:08:11 INFO - 'sessionrestore_no_auto_restore']}, 01:08:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['a11yr', 01:08:11 INFO - 'ts_paint', 01:08:11 INFO - 'tpaint', 01:08:11 INFO - 'sessionrestore', 01:08:11 INFO - 'sessionrestore_no_auto_restore']}, 01:08:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['a11yr', 01:08:11 INFO - 'ts_paint', 01:08:11 INFO - 'tpaint', 01:08:11 INFO - 'sessionrestore', 01:08:11 INFO - 'sessionrestore_no_auto_restore']}, 01:08:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['a11yr', 01:08:11 INFO - 'ts_paint', 01:08:11 INFO - 'tpaint', 01:08:11 INFO - 'sessionrestore', 01:08:11 INFO - 'sessionrestore_no_auto_restore']}, 01:08:11 INFO - 'other_l64': {'tests': ['a11yr', 01:08:11 INFO - 'ts_paint', 01:08:11 INFO - 'tpaint', 01:08:11 INFO - 'sessionrestore', 01:08:11 INFO - 'sessionrestore_no_auto_restore']}, 01:08:11 INFO - 'other_nol64': {'tests': ['a11yr', 01:08:11 INFO - 'ts_paint', 01:08:11 INFO - 'tpaint', 01:08:11 INFO - 'sessionrestore', 01:08:11 INFO - 'sessionrestore_no_auto_restore']}, 01:08:11 INFO - 'svgr': {'tests': ['tsvgx', 01:08:11 INFO - 'tsvgr_opacity', 01:08:11 INFO - 'tart', 01:08:11 INFO - 'tscrollx', 01:08:11 INFO - 'cart']}, 01:08:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['tsvgx', 01:08:11 INFO - 'tsvgr_opacity', 01:08:11 INFO - 'tart', 01:08:11 INFO - 'tscrollx', 01:08:11 INFO - 'cart']}, 01:08:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'tests': ['tp5o']}, 01:08:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'talos_options': ['--e10s'], 01:08:11 INFO - 'tests': ['tp5o']}, 01:08:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'talos_options': ['--xperf_path', 01:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:11 INFO - 'tests': ['tp5n']}, 01:08:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:08:11 INFO - 'talos_options': ['--e10s', 01:08:11 INFO - '--xperf_path', 01:08:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:08:11 INFO - 'tests': ['tp5n']}}, 01:08:11 INFO - 'talos.zip': {'path': '', 01:08:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:08:11 INFO - Running post-action listener: _resource_record_post_action 01:08:11 INFO - ##### 01:08:11 INFO - ##### Running create-virtualenv step. 01:08:11 INFO - ##### 01:08:11 INFO - Running pre-action listener: _resource_record_pre_action 01:08:11 INFO - Running main action method: create_virtualenv 01:08:11 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 01:08:11 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 01:08:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 01:08:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:08:11 INFO - Using real prefix '/usr' 01:08:11 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 01:08:12 INFO - Installing distribute.............................................................................................................................................................................................done. 01:08:14 INFO - Installing pip.................done. 01:08:14 INFO - Return code: 0 01:08:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 01:08:14 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')]} 01:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:14 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')]} 01:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:14 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:14 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 01:08:14 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 01:08:14 INFO - Using env: {'DISPLAY': ':0', 01:08:14 INFO - 'HOME': '/home/cltbld', 01:08:14 INFO - 'LANG': 'en_US.UTF-8', 01:08:14 INFO - 'LANGUAGE': 'en_US:en', 01:08:14 INFO - 'LOGNAME': 'cltbld', 01:08:14 INFO - 'MAIL': '/var/mail/cltbld', 01:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:14 INFO - 'MOZ_NO_REMOTE': '1', 01:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:14 INFO - 'NO_EM_RESTART': '1', 01:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:14 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:14 INFO - 'SHELL': '/bin/bash', 01:08:14 INFO - 'SHLVL': '1', 01:08:14 INFO - 'TERM': 'linux', 01:08:14 INFO - 'TMOUT': '86400', 01:08:14 INFO - 'USER': 'cltbld', 01:08:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:14 INFO - '_': '/tools/buildbot/bin/python'} 01:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:14 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 01:08:14 INFO - Cleaning up... 01:08:14 INFO - Return code: 0 01:08:14 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 01:08:14 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')]} 01:08:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:14 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')]} 01:08:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:14 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:14 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 01:08:14 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 01:08:14 INFO - Using env: {'DISPLAY': ':0', 01:08:14 INFO - 'HOME': '/home/cltbld', 01:08:14 INFO - 'LANG': 'en_US.UTF-8', 01:08:14 INFO - 'LANGUAGE': 'en_US:en', 01:08:14 INFO - 'LOGNAME': 'cltbld', 01:08:14 INFO - 'MAIL': '/var/mail/cltbld', 01:08:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:14 INFO - 'MOZ_NO_REMOTE': '1', 01:08:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:14 INFO - 'NO_EM_RESTART': '1', 01:08:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:14 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:14 INFO - 'SHELL': '/bin/bash', 01:08:14 INFO - 'SHLVL': '1', 01:08:14 INFO - 'TERM': 'linux', 01:08:14 INFO - 'TMOUT': '86400', 01:08:14 INFO - 'USER': 'cltbld', 01:08:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:14 INFO - '_': '/tools/buildbot/bin/python'} 01:08:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:14 INFO - Downloading/unpacking psutil>=0.7.1 01:08:14 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 01:08:14 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 01:08:14 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 01:08:14 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 01:08:14 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 01:08:14 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 01:08:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 01:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:16 INFO - Installing collected packages: psutil 01:08:16 INFO - Running setup.py install for psutil 01:08:16 INFO - building 'psutil._psutil_linux' extension 01:08:16 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 01:08:16 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 01:08:16 INFO - building 'psutil._psutil_posix' extension 01:08:16 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 01:08:16 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 01:08:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:08:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:08:16 INFO - Successfully installed psutil 01:08:16 INFO - Cleaning up... 01:08:17 INFO - Return code: 0 01:08:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 01:08: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')]} 01:08:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08: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')]} 01:08:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:17 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:17 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 01:08:17 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 01:08:17 INFO - Using env: {'DISPLAY': ':0', 01:08:17 INFO - 'HOME': '/home/cltbld', 01:08:17 INFO - 'LANG': 'en_US.UTF-8', 01:08:17 INFO - 'LANGUAGE': 'en_US:en', 01:08:17 INFO - 'LOGNAME': 'cltbld', 01:08:17 INFO - 'MAIL': '/var/mail/cltbld', 01:08:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:17 INFO - 'MOZ_NO_REMOTE': '1', 01:08:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:17 INFO - 'NO_EM_RESTART': '1', 01:08:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:17 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:17 INFO - 'SHELL': '/bin/bash', 01:08:17 INFO - 'SHLVL': '1', 01:08:17 INFO - 'TERM': 'linux', 01:08:17 INFO - 'TMOUT': '86400', 01:08:17 INFO - 'USER': 'cltbld', 01:08:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:17 INFO - '_': '/tools/buildbot/bin/python'} 01:08:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:17 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:08:17 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 01:08:17 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 01:08:17 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 01:08:17 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 01:08:17 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 01:08:17 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 01:08:19 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:08:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:08:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:08:19 INFO - Installing collected packages: mozsystemmonitor 01:08:19 INFO - Running setup.py install for mozsystemmonitor 01:08:19 INFO - Successfully installed mozsystemmonitor 01:08:19 INFO - Cleaning up... 01:08:19 INFO - Return code: 0 01:08:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 01:08:19 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')]} 01:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:19 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')]} 01:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:19 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:19 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 01:08:19 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 01:08:19 INFO - Using env: {'DISPLAY': ':0', 01:08:19 INFO - 'HOME': '/home/cltbld', 01:08:19 INFO - 'LANG': 'en_US.UTF-8', 01:08:19 INFO - 'LANGUAGE': 'en_US:en', 01:08:19 INFO - 'LOGNAME': 'cltbld', 01:08:19 INFO - 'MAIL': '/var/mail/cltbld', 01:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:19 INFO - 'MOZ_NO_REMOTE': '1', 01:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:19 INFO - 'NO_EM_RESTART': '1', 01:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:19 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:19 INFO - 'SHELL': '/bin/bash', 01:08:19 INFO - 'SHLVL': '1', 01:08:19 INFO - 'TERM': 'linux', 01:08:19 INFO - 'TMOUT': '86400', 01:08:19 INFO - 'USER': 'cltbld', 01:08:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:19 INFO - '_': '/tools/buildbot/bin/python'} 01:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:19 INFO - Downloading/unpacking blobuploader==1.2.4 01:08:19 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 01:08:19 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 01:08:19 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 01:08:19 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 01:08:19 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 01:08:19 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 01:08:21 INFO - Downloading blobuploader-1.2.4.tar.gz 01:08:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:08:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 01:08:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 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 01:08:21 INFO - Downloading docopt-0.6.1.tar.gz 01:08:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 01:08:22 INFO - Installing collected packages: blobuploader, requests, docopt 01:08:22 INFO - Running setup.py install for blobuploader 01:08:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:08:22 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 01:08:22 INFO - Running setup.py install for requests 01:08:22 INFO - Running setup.py install for docopt 01:08:22 INFO - Successfully installed blobuploader requests docopt 01:08:22 INFO - Cleaning up... 01:08:22 INFO - Return code: 0 01:08:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:22 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:22 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 01:08:22 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 01:08:22 INFO - Using env: {'DISPLAY': ':0', 01:08:22 INFO - 'HOME': '/home/cltbld', 01:08:22 INFO - 'LANG': 'en_US.UTF-8', 01:08:22 INFO - 'LANGUAGE': 'en_US:en', 01:08:22 INFO - 'LOGNAME': 'cltbld', 01:08:22 INFO - 'MAIL': '/var/mail/cltbld', 01:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:22 INFO - 'MOZ_NO_REMOTE': '1', 01:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:22 INFO - 'NO_EM_RESTART': '1', 01:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:22 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:22 INFO - 'SHELL': '/bin/bash', 01:08:22 INFO - 'SHLVL': '1', 01:08:22 INFO - 'TERM': 'linux', 01:08:22 INFO - 'TMOUT': '86400', 01:08:22 INFO - 'USER': 'cltbld', 01:08:22 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:22 INFO - '_': '/tools/buildbot/bin/python'} 01:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:08:22 INFO - Running setup.py (path:/tmp/pip-StjDq1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:08:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:08:22 INFO - Running setup.py (path:/tmp/pip-GxxicO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:08:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:08:22 INFO - Running setup.py (path:/tmp/pip-h4nSoj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:08:23 INFO - Running setup.py (path:/tmp/pip-lyhpc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:08:23 INFO - Running setup.py (path:/tmp/pip-MNwZxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:08:23 INFO - Running setup.py (path:/tmp/pip-YtxsEK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:08:23 INFO - Running setup.py (path:/tmp/pip-yuIMCy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:08:23 INFO - Running setup.py (path:/tmp/pip-HQceJF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:08:23 INFO - Running setup.py (path:/tmp/pip-ypnDpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:08:23 INFO - Running setup.py (path:/tmp/pip-S0yVS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:08:23 INFO - Running setup.py (path:/tmp/pip-6V_JRz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:08:23 INFO - Running setup.py (path:/tmp/pip-jOs8jB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:08:23 INFO - Running setup.py (path:/tmp/pip-jHWgko-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:08:23 INFO - Running setup.py (path:/tmp/pip-vLqjpq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:08:23 INFO - Running setup.py (path:/tmp/pip-oaed4f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:08:23 INFO - Running setup.py (path:/tmp/pip-5pE22A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:08:23 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:08:23 INFO - Running setup.py (path:/tmp/pip-9zgNjY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:08:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:08:24 INFO - Running setup.py install for manifestparser 01:08:24 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Running setup.py install for mozcrash 01:08:24 INFO - Running setup.py install for mozdebug 01:08:24 INFO - Running setup.py install for mozdevice 01:08:24 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Running setup.py install for mozfile 01:08:24 INFO - Running setup.py install for mozhttpd 01:08:24 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Running setup.py install for mozinfo 01:08:24 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Running setup.py install for mozInstall 01:08:24 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 01:08:24 INFO - Running setup.py install for mozleak 01:08:24 INFO - Running setup.py install for mozlog 01:08:25 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Running setup.py install for moznetwork 01:08:25 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Running setup.py install for mozprocess 01:08:25 INFO - Running setup.py install for mozprofile 01:08:25 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Running setup.py install for mozrunner 01:08:25 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Running setup.py install for mozscreenshot 01:08:25 INFO - Running setup.py install for moztest 01:08:25 INFO - Running setup.py install for mozversion 01:08:25 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 01:08:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:08:25 INFO - Cleaning up... 01:08:25 INFO - Return code: 0 01:08:25 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:25 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:25 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 01:08:25 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 01:08:25 INFO - Using env: {'DISPLAY': ':0', 01:08:25 INFO - 'HOME': '/home/cltbld', 01:08:25 INFO - 'LANG': 'en_US.UTF-8', 01:08:25 INFO - 'LANGUAGE': 'en_US:en', 01:08:25 INFO - 'LOGNAME': 'cltbld', 01:08:25 INFO - 'MAIL': '/var/mail/cltbld', 01:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:25 INFO - 'MOZ_NO_REMOTE': '1', 01:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:25 INFO - 'NO_EM_RESTART': '1', 01:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:25 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:25 INFO - 'SHELL': '/bin/bash', 01:08:25 INFO - 'SHLVL': '1', 01:08:25 INFO - 'TERM': 'linux', 01:08:25 INFO - 'TMOUT': '86400', 01:08:25 INFO - 'USER': 'cltbld', 01:08:25 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:25 INFO - '_': '/tools/buildbot/bin/python'} 01:08:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:08:26 INFO - Running setup.py (path:/tmp/pip-qJ3OIn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:08:26 INFO - Running setup.py (path:/tmp/pip-2DrShX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:08:26 INFO - Running setup.py (path:/tmp/pip-eBa74X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:08:26 INFO - Running setup.py (path:/tmp/pip-OMRLbD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 01:08:26 INFO - Running setup.py (path:/tmp/pip-kubgdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:08:26 INFO - Running setup.py (path:/tmp/pip-6cBKC8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:08:26 INFO - Running setup.py (path:/tmp/pip-5sdEJT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:08:26 INFO - Running setup.py (path:/tmp/pip-H2ik9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 01:08:26 INFO - Running setup.py (path:/tmp/pip-VTir7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 01:08:26 INFO - Running setup.py (path:/tmp/pip-zceSje-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:08:26 INFO - Running setup.py (path:/tmp/pip-tv1ysc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:08:26 INFO - Running setup.py (path:/tmp/pip-Qsxmde-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:08:26 INFO - Running setup.py (path:/tmp/pip-w5WyXi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 01:08:26 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)) 01:08:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:08:26 INFO - Running setup.py (path:/tmp/pip-1AqdR5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:08:27 INFO - Running setup.py (path:/tmp/pip-RAzV2z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 01:08:27 INFO - Running setup.py (path:/tmp/pip-IoaMhW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 01:08:27 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)) 01:08:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 01:08:27 INFO - Running setup.py (path:/tmp/pip-FvmWgZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 01:08:27 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)) 01:08:27 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)) 01:08:27 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)) 01:08:27 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)) 01:08:27 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)) 01:08:27 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)) 01:08:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 01:08:27 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 01:08:27 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 01:08:27 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 01:08:27 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 01:08:27 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 01:08:27 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 01:08:29 INFO - Downloading blessings-1.6.tar.gz 01:08:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 01:08:29 INFO - Installing collected packages: blessings 01:08:29 INFO - Running setup.py install for blessings 01:08:29 INFO - Successfully installed blessings 01:08:29 INFO - Cleaning up... 01:08:29 INFO - Return code: 0 01:08:29 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 01:08:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:08:29 INFO - Reading from file tmpfile_stdout 01:08:29 INFO - Current package versions: 01:08:29 INFO - argparse == 1.2.1 01:08:29 INFO - blessings == 1.6 01:08:29 INFO - blobuploader == 1.2.4 01:08:29 INFO - docopt == 0.6.1 01:08:29 INFO - manifestparser == 1.1 01:08:29 INFO - mozInstall == 1.12 01:08:29 INFO - mozcrash == 0.16 01:08:29 INFO - mozdebug == 0.1 01:08:29 INFO - mozdevice == 0.48 01:08:29 INFO - mozfile == 1.2 01:08:29 INFO - mozhttpd == 0.7 01:08:29 INFO - mozinfo == 0.9 01:08:29 INFO - mozleak == 0.1 01:08:29 INFO - mozlog == 3.1 01:08:29 INFO - moznetwork == 0.27 01:08:29 INFO - mozprocess == 0.22 01:08:29 INFO - mozprofile == 0.28 01:08:29 INFO - mozrunner == 6.11 01:08:29 INFO - mozscreenshot == 0.1 01:08:29 INFO - mozsystemmonitor == 0.0 01:08:29 INFO - moztest == 0.7 01:08:29 INFO - mozversion == 1.4 01:08:29 INFO - psutil == 3.1.1 01:08:29 INFO - requests == 1.2.3 01:08:29 INFO - wsgiref == 0.1.2 01:08:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 01:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:29 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 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:29 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 01:08:29 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 01:08:29 INFO - Using env: {'DISPLAY': ':0', 01:08:29 INFO - 'HOME': '/home/cltbld', 01:08:29 INFO - 'LANG': 'en_US.UTF-8', 01:08:29 INFO - 'LANGUAGE': 'en_US:en', 01:08:29 INFO - 'LOGNAME': 'cltbld', 01:08:29 INFO - 'MAIL': '/var/mail/cltbld', 01:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:29 INFO - 'MOZ_NO_REMOTE': '1', 01:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:29 INFO - 'NO_EM_RESTART': '1', 01:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:29 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:29 INFO - 'SHELL': '/bin/bash', 01:08:29 INFO - 'SHLVL': '1', 01:08:29 INFO - 'TERM': 'linux', 01:08:29 INFO - 'TMOUT': '86400', 01:08:29 INFO - 'USER': 'cltbld', 01:08:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:29 INFO - '_': '/tools/buildbot/bin/python'} 01:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 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)) 01:08:29 INFO - Cleaning up... 01:08:29 INFO - Return code: 0 01:08:29 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 01:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:29 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 01:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:08:29 INFO - Using env: {'DISPLAY': ':0', 01:08:29 INFO - 'HOME': '/home/cltbld', 01:08:29 INFO - 'LANG': 'en_US.UTF-8', 01:08:29 INFO - 'LANGUAGE': 'en_US:en', 01:08:29 INFO - 'LOGNAME': 'cltbld', 01:08:29 INFO - 'MAIL': '/var/mail/cltbld', 01:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:29 INFO - 'MOZ_NO_REMOTE': '1', 01:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:29 INFO - 'NO_EM_RESTART': '1', 01:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:29 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:29 INFO - 'SHELL': '/bin/bash', 01:08:29 INFO - 'SHLVL': '1', 01:08:29 INFO - 'TERM': 'linux', 01:08:29 INFO - 'TMOUT': '86400', 01:08:29 INFO - 'USER': 'cltbld', 01:08:29 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:29 INFO - '_': '/tools/buildbot/bin/python'} 01:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:29 INFO - Downloading/unpacking jsonschema 01:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:08:31 INFO - Downloading/unpacking functools32 (from jsonschema) 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:31 INFO - Downloading functools32-3.2.3-2.tar.gz 01:08:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 01:08:32 INFO - warning: no files found matching '*.txt' 01:08:32 INFO - no previously-included directories found matching 'build' 01:08:32 INFO - no previously-included directories found matching 'dist' 01:08:32 INFO - no previously-included directories found matching '.git*' 01:08:32 INFO - Installing collected packages: jsonschema, functools32 01:08:32 INFO - Running setup.py install for functools32 01:08:32 INFO - warning: no files found matching '*.txt' 01:08:32 INFO - no previously-included directories found matching 'build' 01:08:32 INFO - no previously-included directories found matching 'dist' 01:08:32 INFO - no previously-included directories found matching '.git*' 01:08:32 INFO - Successfully installed jsonschema functools32 01:08:32 INFO - Cleaning up... 01:08:32 INFO - Return code: 0 01:08:32 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 01:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:08:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:08:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:08:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:08:32 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb091f6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1562670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, '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': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', '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 01:08:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 01:08:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:08:32 INFO - Using env: {'DISPLAY': ':0', 01:08:32 INFO - 'HOME': '/home/cltbld', 01:08:32 INFO - 'LANG': 'en_US.UTF-8', 01:08:32 INFO - 'LANGUAGE': 'en_US:en', 01:08:32 INFO - 'LOGNAME': 'cltbld', 01:08:32 INFO - 'MAIL': '/var/mail/cltbld', 01:08:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:32 INFO - 'MOZ_NO_REMOTE': '1', 01:08:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:32 INFO - 'NO_EM_RESTART': '1', 01:08:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:32 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:32 INFO - 'SHELL': '/bin/bash', 01:08:32 INFO - 'SHLVL': '1', 01:08:32 INFO - 'TERM': 'linux', 01:08:32 INFO - 'TMOUT': '86400', 01:08:32 INFO - 'USER': 'cltbld', 01:08:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:32 INFO - '_': '/tools/buildbot/bin/python'} 01:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:08:32 INFO - Downloading/unpacking flake8 01:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:08:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:08:34 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:08:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 01:08:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:08:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:08:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:08:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:08:34 INFO - no previously-included directories found matching 'docs/_build' 01:08:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:08:35 INFO - Running setup.py install for pep8 01:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:08:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:08:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:08:35 INFO - no previously-included directories found matching 'docs/_build' 01:08:35 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 01:08:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:08:35 INFO - Cleaning up... 01:08:35 INFO - Return code: 0 01:08:35 INFO - Running post-action listener: _resource_record_post_action 01:08:35 INFO - Running post-action listener: _start_resource_monitoring 01:08:35 INFO - Starting resource monitoring. 01:08:35 INFO - ##### 01:08:35 INFO - ##### Running install step. 01:08:35 INFO - ##### 01:08:35 INFO - Running pre-action listener: _resource_record_pre_action 01:08:35 INFO - Running main action method: install 01:08:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 01:08:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 01:08:35 INFO - Reading from file tmpfile_stdout 01:08:35 INFO - Detecting whether we're running mozinstall >=1.0... 01:08:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 01:08:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 01:08:35 INFO - Reading from file tmpfile_stdout 01:08:35 INFO - Output received: 01:08:35 INFO - Usage: mozinstall [options] installer 01:08:35 INFO - Options: 01:08:35 INFO - -h, --help show this help message and exit 01:08:35 INFO - -d DEST, --destination=DEST 01:08:35 INFO - Directory to install application into. [default: 01:08:35 INFO - "/builds/slave/test-pgo"] 01:08:35 INFO - --app=APP Application being installed. [default: firefox] 01:08:35 INFO - mkdir: /builds/slave/test-pgo/build/application 01:08:35 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'] 01:08:35 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 01:08:51 INFO - Reading from file tmpfile_stdout 01:08:51 INFO - Output received: 01:08:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 01:08:51 INFO - Running post-action listener: _resource_record_post_action 01:08:51 INFO - ##### 01:08:51 INFO - ##### Running run-tests step. 01:08:51 INFO - ##### 01:08:51 INFO - Running pre-action listener: _resource_record_pre_action 01:08:51 INFO - Running main action method: run_tests 01:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 01:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 01:08:51 INFO - Python 2.7.3 01:08:51 INFO - Return code: 0 01:08:51 INFO - grabbing minidump binary from tooltool 01:08: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')]} 01:08:51 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 0x15f18c0>, '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 0x15f27c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f2c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 01:08:51 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 01:08:51 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 01:08:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:08:51 INFO - Return code: 0 01:08:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 01:08:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 01:08:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 01:08:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 01:08:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 01:08:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 01:08:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 01:08:52 INFO - Return code: 0 01:08:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 01:08:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:08:52 INFO - Using env: {'DISPLAY': ':0', 01:08:52 INFO - 'HOME': '/home/cltbld', 01:08:52 INFO - 'LANG': 'en_US.UTF-8', 01:08:52 INFO - 'LANGUAGE': 'en_US:en', 01:08:52 INFO - 'LOGNAME': 'cltbld', 01:08:52 INFO - 'MAIL': '/var/mail/cltbld', 01:08:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:08:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 01:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:08:52 INFO - 'MOZ_NO_REMOTE': '1', 01:08:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 01:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:08:52 INFO - 'NO_EM_RESTART': '1', 01:08:52 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 01:08:52 INFO - 'PWD': '/builds/slave/test-pgo', 01:08:52 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 01:08:52 INFO - 'SHELL': '/bin/bash', 01:08:52 INFO - 'SHLVL': '1', 01:08:52 INFO - 'TERM': 'linux', 01:08:52 INFO - 'TMOUT': '86400', 01:08:52 INFO - 'USER': 'cltbld', 01:08:52 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091', 01:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:08:52 INFO - '_': '/tools/buildbot/bin/python'} 01:08:52 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:08:53 INFO - mozversion application_buildid: 20160216200457 01:08:53 INFO - mozversion application_changeset: 1b3ab4045d79f6a136f1b2b7707d59fe82f85fa3 01:08:53 INFO - mozversion application_display_name: Nightly 01:08:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:08:53 INFO - mozversion application_name: Firefox 01:08:53 INFO - mozversion application_remotingname: firefox 01:08:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:08:53 INFO - mozversion application_vendor: Mozilla 01:08:53 INFO - mozversion application_version: 47.0a1 01:08:53 INFO - mozversion platform_buildid: 20160216200457 01:08:53 INFO - mozversion platform_changeset: 1b3ab4045d79f6a136f1b2b7707d59fe82f85fa3 01:08:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:08:53 INFO - mozversion platform_version: 47.0a1 01:08:53 INFO - using testdate: 1455700133 01:08:53 INFO - actual date: 1455700133 01:08:53 INFO - starting webserver on 'localhost:49030' 01:08:53 INFO - SUITE-START | Running 2 tests 01:08:53 INFO - TEST-START | dromaeo_css 01:08:53 INFO - operating with platform_type : linux_ 01:08:53 INFO - Initialising browser for dromaeo_css test... 01:08:53 INFO - TEST-INFO | started process 7090 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHJ14ox/profile http://localhost:49030/getInfo.html) 01:08:56 INFO - PROCESS | 7090 | 01:08:56 INFO - PROCESS | 7090 | (process:7172): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:08:57 INFO - PROCESS | 7090 | __metrics Screen width/height:1600/1200 01:08:57 INFO - PROCESS | 7090 | colorDepth:24 01:08:57 INFO - PROCESS | 7090 | Browser inner width/height: 1024/697 01:08:57 INFO - PROCESS | 7090 | __metrics 01:08:58 INFO - TEST-INFO | 7090: exit 0 01:08:58 INFO - Browser initialized. 01:08:58 INFO - Running cycle 1/1 for dromaeo_css test... 01:08:58 INFO - TEST-INFO | started process 7223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHJ14ox/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:09:00 INFO - PROCESS | 7223 | 01:09:00 INFO - PROCESS | 7223 | (process:7280): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:09:10 INFO - PROCESS | 7223 | RSS: Main: 157855744 01:09:10 INFO - PROCESS | 7223 | 01:10:00 INFO - PROCESS | 7223 | 1455700200362 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] 01:12:09 INFO - PROCESS | 7223 | Cycle 1(1): loaded http://localhost:49030/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49030/tests/dromaeo/cssquery-ext.html) 01:12:10 INFO - PROCESS | 7223 | RSS: Main: 166449152 01:12:10 INFO - PROCESS | 7223 | 01:15:12 INFO - PROCESS | 7223 | Cycle 1(1): loaded http://localhost:49030/tests/dromaeo/cssquery-ext.html (next: http://localhost:49030/tests/dromaeo/cssquery-jquery.html) 01:15:12 INFO - PROCESS | 7223 | RSS: Main: 162557952 01:15:12 INFO - PROCESS | 7223 | 01:18:14 INFO - PROCESS | 7223 | Cycle 1(1): loaded http://localhost:49030/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49030/tests/dromaeo/cssquery-mootools.html) 01:18:15 INFO - PROCESS | 7223 | RSS: Main: 162471936 01:18:15 INFO - PROCESS | 7223 | 01:21:16 INFO - PROCESS | 7223 | Cycle 1(1): loaded http://localhost:49030/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49030/tests/dromaeo/cssquery-prototype.html) 01:21:17 INFO - PROCESS | 7223 | RSS: Main: 159354880 01:21:17 INFO - PROCESS | 7223 | 01:24:19 INFO - PROCESS | 7223 | Cycle 1(1): loaded http://localhost:49030/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49030/tests/dromaeo/cssquery-yui.html) 01:24:20 INFO - PROCESS | 7223 | RSS: Main: 159584256 01:24:20 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | Cycle 1(1): loaded http://localhost:49030/tests/dromaeo/cssquery-yui.html (next: http://localhost:49030/tests/dromaeo/cssquery-dojo.html) 01:27:23 INFO - PROCESS | 7223 | RSS: Main: 163282944 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | __start_tp_report 01:27:23 INFO - PROCESS | 7223 | _x_x_mozilla_page_load 01:27:23 INFO - PROCESS | 7223 | _x_x_mozilla_page_load_details 01:27:23 INFO - PROCESS | 7223 | |i|pagename|runs| 01:27:23 INFO - PROCESS | 7223 | |0;dojo.html;3205.1346136543148;3229.208843833261;3245.4158251514746;3267.7712560120785;3277.3772983133213;5171.689698618076;5194.091034069037;5230.529252367286;5231.607629427798;5243.55429788468;5343.919841202375;5381.730913454331;5406;5409.9459005410035;5420.728963551826;4894.706317620954;4952.975235123819;4992.375953005874;4999.650024498286;5080.822171224008;4831.975840120812;4982.725950072744;4995.375578052744;5027.522385373383;5045.0666626674;4801.159797035505;4802;4879;4936.062148191868;4937;4832.782524786393;4880.780364883589;4883.8534843954385;4887.242477415971;4927.285543596195;4768.451628062782;4841.612670986313;4847.830325938575;4861.222204447272;4917.0903382874285;5126.154184559543;5188.870278243036;5213.061648903196;5235.39792923811;5249.055170069386;5670.68811215383;5674.517665998395;5679.403662615448;5680.488756011979;5700.800471983503;5607.523360514361;5735.1970724098655;5775.480206781368;5790.942090579125;5900.468957793776;5461.453854614547;5462.481064298885;5472.042392581322;5478.233047373371;5483.369412517612;5893.5874488785375;5901.996660567714;5927.110933360031;5939.881202375928;5948.583599148104;5566.666000040011;5629.24005259293;5642.971785141048;5644.915326270109;5646.689432081275;5594.440555944373;5642.210090587321;5672.97163514188;5798.188253644493;5848;5569.805056822992;5577.3028371453565;5587.329520457572;5611.2144299798065;5625.324961004706;5567.610267281251;5593.328800543961;5612.831615051555;5627.943720562742;5634.126710359901;4249.553796851348;4344.717593356485;4383.736975781463;4400.207962566705;4439.889002774957;3940.2316548273384;3946.901327466779;3962.108525581721;3978.403239514096;3980.4029395590314;5255.658382205144;5310.007974481674;5358.705271210121;5392.487713667196;5396.595255355864;5667.4615911488345;5708.40061793514;5727.05503591911;5755.625884317506;5809.796657116981;5355.973220133875;5367.302250707383;5381;5382.2464854920345;5384.488473595002;4759.928601070987;4825.927611085836;4847.660663753574;4854.781534830941;4881.365422495124;5963.194968679346;5965.105234214816;5977.282726072899;5984.192134061933;6016.368281330485;5695.373508914099;5717.485426311652;5720.513756330759;5725.312962444534;5727.799527016535;5909.261342332208;5947.167396564398;5985.431384018511;6005.309389420273;6058.697065146637;5618.494335509824;5665.716714164358;5666.546676265972;5672.2342483765815;5673.631213971079;5718.313802343745;5745.655260684205;5758.884822303614;5763.6541807491685;5766.163906233656;5504.4770746778995;5557.972210138923;5579.74891129892;5628.943710563006;5664.348599911063;5582.358028826737;5584.301962254718;5586.273784408001;5598.188262701804;5630.887382252414;5296.947030529645;5482.862928426821;5507.476789704971;5529.281193444826;5556.72216389187;5651.915221271766;5668.433156684298;5670.886582268249;5692.800751973661;5693.829185124453;5463.07127788269;5525.751341189576;5555.972220139035;5558.02734521449;5559.16612508127 01:27:23 INFO - PROCESS | 7223 | |1;ext.html;494.1352632892438;529.8966701493208;530.6603773584906;546.6419495230624;585.8593937455012;36058.819705901464;36474;36623.08442288938;36661.45007824882;36679.08302292441;39591.40612890802;39687;39737.403938940864;40212.59787402125;40238;8458.069612342653;8593.95703021484;8603.827923441528;8645.69740059098;8669.826603467958;8466.407351485399;8578.142185781404;8596.8710469343;8631.482111073325;8638.09300023498;8791.560421978907;8861.955690221539;8864;8882.822343553125;8888.422252553595;8498.78753031173;8564.828703425928;8566.614502347378;8822.11778822119;8842.778930526723;8734.213920747163;8822.382433229677;8842.42524235929;8862.955685221532;8884.422512536665;39330.213395731924;39965.801025968976;40035.799821001;40040.799796000836;40124.197516049804;3226.451503244454;3295.802251864872;3336.0492259705866;3433.914152146216;3598.3702852001056;29460.11619651414;30105.69894301051;30442.54336184959;30595;31341.529877051864;3609.1338078860886;3707.8331475083414;3737.439384092408;3755.117547376364;3755.1191432262776;253071;254207;254234;254381;255360;53956;60640;61067.389326107055;66993.66012679816;68666.96999544911;54537.72731136398;54548.18177727337;54645.1803222952;54805;55135.172972405446;14267.500637477846;14379.496717615042;14391.92804035994;14400.639984000274;14402;11776.941115294369;11975.46110425033;11978.700532486757;12001.579944701894;12007.819882701766;20635.4841128973;20963;20965;20989.580208395746;21210.893945530483;7771.92228077712;7802.687892484237;7854.528728276322;7876.763697089096;7998.520088794575;887.2857349833317;926.1942110364026;1000.5247507434057;1022.3508072374096;1063.5320458998017;28844.567331490045;30400.847995760323;30783;30868.845655771576;31138.377232455223;985.393982700634;1026.7022563456662;1034.6689059500889;1051.3849398102043;1112.6328311657296;13935;13964;13973.79039314411;13984.790228146587;14014;383973;392389;393748;393890;397636;53242.7337863316;53530.732346338795;53891;53900.73049634727;53937;1283.2108253424076;1302.5636411802152;1308.3458270864567;1311.5475161069417;1314.0538812055304;26810.11951078356;26938.730612693624;27702.307442313297;27721.722782771914;27738.306542335795;44039.77980110207;44428;44702.776486117364;44723.77638111789;44922.3261651069;296853;298301;299049;299086;299815;31931.201719956258;44096.779516102215;44200;44764.77617611891;44889.551104488535;37885;38851.417228741026;38859;39537.80231098826;39711;33607.15982100467;33953;34739.478907816905;35196.47205291872;36610.8169459151;36613.26773464462;36641;39088.6091139085;41712.58287417208;42712;35287.64712352843;35492.112697182776;35577.46633800443;38658.2268354637;39331.803340984254;29298.267543311587;30849.845750771103;31189;31453;33033;25099.74900250974;25115.246542603752;25307.74692253054;25495.617565736156;25626.359341016625 01:27:23 INFO - PROCESS | 7223 | |2;jquery.html;364.71187761668284;366.5399923096513;371.05936451096466;373.82430257778833;374.7863717680923;16195.838041619594;17076.231569579366;17264;17705.7344139838;17987.37044203453;10814;11911.702207444796;16090.1954902255;16544.503664890042;16639.41762038329;5007.774650140753;5549.833504994856;5551.333839939213;5586.190002449643;5589.496945274925;4685.180093483644;5127.9230811537855;5450.5367043801325;5531;5561.388247292794;5059.064073146461;5132.6407151499225;5150.690958542481;5254.789808407678;5295.0998330283755;5157.948420515821;5173.405058418292;5207.531322181003;5230.267762513251;5529.115341545334;5412;5416.83749487516;5422.91865622016;5431.83704488866;5437.13005919051;15145.318460669187;19648.901755491275;20510.282140125026;20583.176672933216;20712.48218794542;1835.9541011474687;1934.2359767891603;1943.7473128493348;2338.8012018978407;2445.9266222013366;9510.762230944212;9599.568019439143;11190.776184476346;12345.753084938251;12774;1871.2982631513182;1900.8194221548931;1951.7950615185484;1985.0967809646577;1994.2621230144794;65788.67105664441;69746;70026;70938.64530677313;71172.28827711761;15193.316300766492;15311.46409875649;15698.843011569737;15741.291641876143;15818.209089545477;24073.157439489532;24074;24341.756582434304;24557.263282101565;24561.631575526382;8662.956685216534;8713.825723485621;8759.649614015496;8907.376483646083;8910.643574257087;7380.114386273574;7382.114146302478;7385.778426647209;7448.702051917971;7454.701811927571;7668.463207575416;7774.92225077742;7775.105862825847;7828;7835.882461763078;1846.6122114355867;1908.4465505003393;3120.3135310231714;3220.903372898817;3240.157559034668;792.4611264340303;861.2722249698994;882.7263548300048;964.3779762053437;1004.7387679203459;15892.205389730467;16037.438689645807;16617.750733739005;17149.828501715074;17868.195931183127;875.9036505984336;906.1482206725657;915.2312057871287;915.7481692534473;952.9952350238204;9816.754581135528;10031.448270345056;10051;10117.67293522494;10133.493325333704;482074;567381;573696;575024;575167;75237.62381188168;77533;78143;80312.59843700744;80348.19651803524;1156.1444531046964;1161.268400907423;1166.1079274355125;1168.9006434452997;1172.935488548121;15373.615659608151;15520.84479155194;15607.375704972128;15614.765778513105;15683.686326273639;34645.826770865984;35650.28699426049;35731;35798.28403431969;36611.450828237066;43308;43450;43610;44182.77908610436;46457.07085858331;7766.5728384939375;7966;7979;8007.1592482788465;8061.556614386265;10548.36709797384;11465.770684586429;12172.513099476277;12339.444724987217;12528.686782830502;10033.548490317808;10692.89307106919;10803.837942431028;11039.889601103887;11147.108231341635;10430.582776688847;10563.524641391003;10605.681829545127;10750.946245268724;11023.61417350389;9685.225181985283;10265.538050787583;10744.677659670222;10903.073238774476;11020.944895275472;8024.478408903403;8074.475159114639;8077.717279895175;8093.0692970309165;8132.83734325322;9522.8096487939;9980.900190998287;10212.285140040125;10516.526756295832;10656 01:27:23 INFO - PROCESS | 7223 | |3;mootools.html;1397.9930100349497;1418.546065259117;1560.42264362186;1739.0435260606664;1750.6498700259942;7270.163931147919;7472.850542989144;7499.287567681075;7773.7279195228175;7924.92075079249;7694.692212311501;7738.496997695146;7752.263534964183;7800.1419843817275;7815.413843961712;2236.563870045342;2237.474193564511;2245.932622021342;2253.4704344479032;2261.2198791416936;2237.1163390460756;2270.2735124760084;2270.545890821834;2274.55646149001;2281.7946384825364;1993.252530301137;2202.196198387585;2245.8877056147207;2260.9660855087104;2286.7827556382117;2202.702635144251;2217.3458829645215;2229.554089182154;2237.451824303048;2238.507528343762;2217.1463986365206;2229.3534874886263;2231.843770936035;2239.9776002239932;2245.0346351069034;7719.3052625264;7744.922550774477;7749.108852481981;7751.263629955145;7766.57283849388;4612.031473390592;4739.857804265877;4748.857534273943;4751.3348131261655;4763.809447622091;2994.1017694691504;3024.010382868263;3081.9691803081905;3089.1813669377634;3112.517559778238;992.1368409483796;993.126049076815;1033.5504055735703;1034.963776267827;1040.5733649203867;10757.246992710514;10817.35095894241;10846.240763146583;10868.728281793019;10881.83677244842;4098.180363927167;4127.484064491939;4148;4196.979015104905;4202.621764041251;8526.914730852735;8561.743147705578;8576.571171441528;8590.1839325264;8602.655893764304;4642.907141857144;4662.860114196579;4666.626669866402;4670.439547254351;4673.088747694235;4316.374125751749;4316.935245971313;4341.39220509129;4369.847055353048;4385.846495372647;3439.3809114359656;3441.4665726812386;3442.7417943654327;3475.218075932895;3495.9825200873834;1069.5187165775433;1073.4042606353394;1080.1628737728167;1088.1566785741113;1091.0344345254348;899.3075331994328;1058.1746237934424;1096.2600244834864;1147.0566328177504;1267.4423253768311;7275.854482910312;7306.159791623925;7400.851982960311;7414.110306763115;7445.292697193866;595.684287327717;599.3317451042057;632.6804963493498;635.3329004545209;751.7483390155439;5508.14623733314;5561.249231353796;5600.411956744565;5672.688002159921;5693.544516438675;9319.114684105134;9769.31614786958;9771.853422198672;9808.313418060667;9856.359336643096;9358.485283309346;9450.669226577036;9583.233341332676;9588.37675551087;9618.903810961801;7484.625768711543;7544.962275188699;7568.5458872467825;7569.129550101698;7575.924240757522;7112.964435177998;7173.390261827594;7179.964100179465;7211.2428195038765;7242.637868106468;8260.917390826015;8466.57667116654;8539.573021348784;8542.145785421408;8622.913770862211;8660.307175426076;8816.338774591803;8860.512671803113;8899.421537600294;8984.416012959136;6494.512911531749;6558.573692709959;6565.934340656723;6569.178852643419;6589.341065893373;7541.849163016818;7556.508826926232;7611.657475413509;7636;7678.616069196406;7147.499675022698;7205.171405288459;7224.566526008456;7365.558066516026;7396.593187374746;6304.873902521832;6857.314268573103;6908.205556361083;7018.841891087914;7052.541584796972;6745.831354216184;7036.19083805369;7039.627272681778;7046.436285097282;7055.2591977841585;6410.166678331787;6522.510811689048;6538.1827271591055;6544.280129185881;6558.606483610808;6212.223472065992;6229.625506877793;6496.350364963466;6499.6425196612745;6506.186726659168 01:27:23 INFO - PROCESS | 7223 | |4;prototype.html;333.05246573498397;336.8484182118047;341.2918194745901;346.4474163708887;348.9738269629777;6212.471939885115;6267.905981410283;6333.7149828257725;6349.142865713127;6383.489320854326;6332.715027823748;6353.618782873031;6365.204349456318;6391.328910464404;6407.359264073591;4842.83050093245;4845.563899249085;4855.902881942359;4859.198232291667;4868.805247790084;4870.537298956593;4871;4889.291052797343;4892.951070489303;4898.53463920927;4591.7244965302025;4720.787564559603;4731.834385796497;4733.952660473403;4769.4515130760055;4729;4729.503402142795;4741.265103908882;4741.952580474185;4748.667593268473;4104.486939132608;4106.445629839964;4112.074783173762;4115.567865374122;4117.773522456264;5859.1504231886565;5977.970110149421;5979.312379076375;5985.521158307325;5986.042233242704;5528.612997090206;5529.972350138264;5530.446955304437;5532.114861622121;5532.612717109763;6612.93387066128;6645.734170633169;6648.235452922928;6662.800115996528;6666.833329166761;4386.758728269944;4528.230200865861;4540.069285796404;4541.296099104644;4544.840930567414;6972.407345375649;7002.054722612433;7006.01915731798;7019.034670292326;7047.823804404879;4630.814767409333;4634.490206077328;4639.86080417588;4641.791119399635;4647.140279048387;4689.437267527918;4695.460022097434;4697.459792123881;4698.2247929092;4706.764661766898;5346.946530534723;5476.096444086681;5501.669899806025;5503.862403439946;5514.889702205934;6700.894352431794;6721.966390168018;6749.156355455568;6751.628660423724;6760.594364338155;1630.7227771278674;1655.337864854068;1661.6261341198376;1661.900285982845;1663.1767275198854;1094.6661268313242;1095.9780804384027;1097.5390336058874;1118.1837258800958;1119.2501024313729;6346.048092786026;6366.713497892606;6375.139356186855;6383.329750376237;6388.776392826228;6923.4807389446;6940.583564986117;6953.374196322356;6961.895571566431;6969.23338432772;6150.938490615126;6323.52573556985;6352.809415717444;6371.23545174582;6375.521835862236;3745.4756334113245;3785.6971442284553;3810.7523011004196;3830.042489377656;3846.076941534068;7302.1967583565765;7362.484626076231;7374.926250737424;7375.520591161558;7398.482106252618;7009.018737376771;7196.10048743907;7197.820054498679;7202;7216.67524961378;7353.227911069261;7358.41132709382;7365.2634736525915;7378.29906158914;7387.1135463744695;7001.614911179934;7008.018877357276;7010.824729381602;7014.473914456538;7034.824129396806;6687.598744075371;6794;6884.759033433806;6902.240753517009;6907.412869905913;7293.489455738048;7310.8903366448485;7324.487285889936;7330.560166390033;7370.6314684266645;4638.188317044436;4661.86014419568;4678.438587369401;4679.181143299841;4681.648876334357;6857;6956.443484521327;7042.964785176041;7050.929490705233;7053.753118641028;6729.69716362755;6733.6296503692765;6739.764108256383;6761.425278851353;6789.709955108514;6632.2372927114;6691.631960242039;6741.764038258638;6777.864442711019;6791;6621.602703837785;6627.204735431779;6633.237177724431;6643.50173736962;6668.433183179484;6757.493188011017;6776.322367763184;6781.355771201728;6808.65956702153;6812.807758642119;6534.117894084237;6634.170728658918;6634.933650663625;6660.6336651484635;6667.833304167435 01:27:23 INFO - PROCESS | 7223 | |5;yui.html;702.2977022977022;727.5343779980814;743.4201322968086;772.4013889235841;786.6538722961893;13499.79750303745;13548.390322435489;13560.525381611646;13568.728625427499;13682.863171368295;12788.424520896559;12853.164544304615;12894.355282235898;12990.480380784757;13017.414216360263;676.2898956096079;814.0353680888137;832.0348395860802;843.797488602734;861.1474640106281;842.2293601354753;842.5787106446777;842.8862103616025;848.8514509960763;849.2993280543576;899.4333569850985;901.5852707754441;902.2466240689;904.0326850270213;905.4748246017327;892.0499667853715;893.5353616119646;893.8927328720563;895.2524641924001;898.9550522473883;656.8620589676174;658.2298710508717;662.3211208511266;662.5163630549678;665.7936039827669;13224.206547607078;13251.86748132516;13269.800952985714;13313.733725325535;13353.399097040656;12322.81515777264;12341.444634991447;12652.68368290791;12664.936675316656;12717.046221533423;10145.137663298554;10165;10306.227032972482;10830.945845270724;11041.33751974884;3590.964090359089;3603.387424137903;3646.835892384849;3657.3233951719017;3741.9896627910584;47433.28850067252;48320.27519587174;48487.03025939497;48513;48607;8643.154104752259;8758.518281494451;8770.605322760492;8904.643814247487;8957.552122393985;17286.22212000438;17802.5549361267;17804.732929006077;17837;17855.553611159565;7303.817404564822;7342.596157211405;7460.515066520658;7551;7574.848503029909;4073.6944729145434;4141.275276826544;4142.2958097123565;4278.935815962701;4356.934645980313;3116.5792617996735;3169.397814415254;3205.086550333144;3220.6618305077627;3232.078857525594;590.2887021139517;591.4588151841017;593.3769541980989;597.6712807955607;616.5067945643557;522.6524361299693;600.5765935015803;609.5397974529202;631.9494440444753;669.2604671837647;7857;7862.331701805296;7916.287534121957;8328.541930193898;8394.160583941557;496.42662724553196;613.8465383654086;615.227888999303;622.2949119412866;624.4411251929498;3865.7487263327794;3922.3332033554366;3926.6269704378037;3990.3216453203027;4085.4484644573195;55586.44413555894;56838.147427788615;57121.428785711614;57168.142477862864;57381.42618573844;49394.259086113736;49421;49992.50007499878;50035.24947125796;50411;44298.11403771907;44359.77820110943;44662.553374466486;45035.77482112503;45044.09911801811;7986.720464783704;8338.953465307266;8382.622781974947;8495.787605309917;8526.104759000216;34871;34945;35045.47431788576;35088;35542.289154216254;39929.80035099806;41355;43901.12197755963;43930.56069439265;44109.77945110254;9968.202543796624;9988.450635215133;10029.899701003189;10657.413842238751;10799.838002430128;11499.13756468285;11731.824022639837;11945.761084778429;12002.279863207887;12334.876651233373;10615.31000484966;10658.573657053632;10713;11001.559937602406;11005.17461190398;10808.621698240524;10811.729706757395;10944.069754070993;10945.452727363441;11074.612388566362;10754.946225268823;10903.454827258447;10904.454777261264;10959.671209863716;10996.395198264172;9290;9332.253419726541;9394.859077113986;9563.808723825345;9924.702258932244;8566.657333706831;9333.439993600407;9396.342256042011;9458.95270523643;9526.952365238129 01:27:23 INFO - PROCESS | 7223 | __end_tp_report 01:27:23 INFO - PROCESS | 7223 | __start_cc_report 01:27:23 INFO - PROCESS | 7223 | _x_x_mozilla_cycle_collect,305 01:27:23 INFO - PROCESS | 7223 | __end_cc_report 01:27:23 INFO - PROCESS | 7223 | __startTimestamp1455701243442__endTimestamp 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | ------- Summary: start ------- 01:27:23 INFO - PROCESS | 7223 | Number of tests: 6 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | [#0] dojo.html Cycles:165 Average:5319.89 Median:5555.97 stddev:584.75 (10.5%) stddev-sans-first:562.52 01:27:23 INFO - PROCESS | 7223 | Values: 3205.1 3229.2 3245.4 3267.8 3277.4 5171.7 5194.1 5230.5 5231.6 5243.6 5343.9 5381.7 5406.0 5409.9 5420.7 4894.7 4953.0 4992.4 4999.7 5080.8 4832.0 4982.7 4995.4 5027.5 5045.1 4801.2 4802.0 4879.0 4936.1 4937.0 4832.8 4880.8 4883.9 4887.2 4927.3 4768.5 4841.6 4847.8 4861.2 4917.1 5126.2 5188.9 5213.1 5235.4 5249.1 5670.7 5674.5 5679.4 5680.5 5700.8 5607.5 5735.2 5775.5 5790.9 5900.5 5461.5 5462.5 5472.0 5478.2 5483.4 5893.6 5902.0 5927.1 5939.9 5948.6 5566.7 5629.2 5643.0 5644.9 5646.7 5594.4 5642.2 5673.0 5798.2 5848.0 5569.8 5577.3 5587.3 5611.2 5625.3 5567.6 5593.3 5612.8 5627.9 5634.1 4249.6 4344.7 4383.7 4400.2 4439.9 3940.2 3946.9 3962.1 3978.4 3980.4 5255.7 5310.0 5358.7 5392.5 5396.6 5667.5 5708.4 5727.1 5755.6 5809.8 5356.0 5367.3 5381.0 5382.2 5384.5 4759.9 4825.9 4847.7 4854.8 4881.4 5963.2 5965.1 5977.3 5984.2 6016.4 5695.4 5717.5 5720.5 5725.3 5727.8 5909.3 5947.2 5985.4 6005.3 6058.7 5618.5 5665.7 5666.5 5672.2 5673.6 5718.3 5745.7 5758.9 5763.7 5766.2 5504.5 5558.0 5579.7 5628.9 5664.3 5582.4 5584.3 5586.3 5598.2 5630.9 5296.9 5482.9 5507.5 5529.3 5556.7 5651.9 5668.4 5670.9 5692.8 5693.8 5463.1 5525.8 5556.0 5558.0 5559.2 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | [#1] ext.html Cycles:180 Average:48249.90 Median:3746.28 stddev:84122.25 (2245.5%) stddev-sans-first:84281.82 01:27:23 INFO - PROCESS | 7223 | Values: 494.1 529.9 530.7 546.6 585.9 36058.8 36474.0 36623.1 36661.5 36679.1 39591.4 39687.0 39737.4 40212.6 40238.0 8458.1 8594.0 8603.8 8645.7 8669.8 8466.4 8578.1 8596.9 8631.5 8638.1 8791.6 8862.0 8864.0 8882.8 8888.4 8498.8 8564.8 8566.6 8822.1 8842.8 8734.2 8822.4 8842.4 8863.0 8884.4 39330.2 39965.8 40035.8 40040.8 40124.2 3226.5 3295.8 3336.0 3433.9 3598.4 29460.1 30105.7 30442.5 30595.0 31341.5 3609.1 3707.8 3737.4 3755.1 3755.1 253071.0 254207.0 254234.0 254381.0 255360.0 53956.0 60640.0 61067.4 66993.7 68667.0 54537.7 54548.2 54645.2 54805.0 55135.2 14267.5 14379.5 14391.9 14400.6 14402.0 11776.9 11975.5 11978.7 12001.6 12007.8 20635.5 20963.0 20965.0 20989.6 21210.9 7771.9 7802.7 7854.5 7876.8 7998.5 887.3 926.2 1000.5 1022.4 1063.5 28844.6 30400.8 30783.0 30868.8 31138.4 985.4 1026.7 1034.7 1051.4 1112.6 13935.0 13964.0 13973.8 13984.8 14014.0 383973.0 392389.0 393748.0 393890.0 397636.0 53242.7 53530.7 53891.0 53900.7 53937.0 1283.2 1302.6 1308.3 1311.5 1314.1 26810.1 26938.7 27702.3 27721.7 27738.3 44039.8 44428.0 44702.8 44723.8 44922.3 296853.0 298301.0 299049.0 299086.0 299815.0 31931.2 44096.8 44200.0 44764.8 44889.6 37885.0 38851.4 38859.0 39537.8 39711.0 33607.2 33953.0 34739.5 35196.5 36610.8 36613.3 36641.0 39088.6 41712.6 42712.0 35287.6 35492.1 35577.5 38658.2 39331.8 29298.3 30849.8 31189.0 31453.0 33033.0 25099.7 25115.2 25307.7 25495.6 25626.4 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | [#2] jquery.html Cycles:180 Average:29367.41 Median:18489.00 stddev:90879.58 (491.5%) stddev-sans-first:91108.42 01:27:23 INFO - PROCESS | 7223 | Values: 364.7 366.5 371.1 373.8 374.8 16195.8 17076.2 17264.0 17705.7 17987.4 10814.0 11911.7 16090.2 16544.5 16639.4 5007.8 5549.8 5551.3 5586.2 5589.5 4685.2 5127.9 5450.5 5531.0 5561.4 5059.1 5132.6 5150.7 5254.8 5295.1 5157.9 5173.4 5207.5 5230.3 5529.1 5412.0 5416.8 5422.9 5431.8 5437.1 15145.3 19648.9 20510.3 20583.2 20712.5 1836.0 1934.2 1943.7 2338.8 2445.9 9510.8 9599.6 11190.8 12345.8 12774.0 1871.3 1900.8 1951.8 1985.1 1994.3 65788.7 69746.0 70026.0 70938.6 71172.3 15193.3 15311.5 15698.8 15741.3 15818.2 24073.2 24074.0 24341.8 24557.3 24561.6 8663.0 8713.8 8759.6 8907.4 8910.6 7380.1 7382.1 7385.8 7448.7 7454.7 7668.5 7774.9 7775.1 7828.0 7835.9 1846.6 1908.4 3120.3 3220.9 3240.2 792.5 861.3 882.7 964.4 1004.7 15892.2 16037.4 16617.8 17149.8 17868.2 875.9 906.1 915.2 915.7 953.0 9816.8 10031.4 10051.0 10117.7 10133.5 482074.0 567381.0 573696.0 575024.0 575167.0 75237.6 77533.0 78143.0 80312.6 80348.2 1156.1 1161.3 1166.1 1168.9 1172.9 15373.6 15520.8 15607.4 15614.8 15683.7 34645.8 35650.3 35731.0 35798.3 36611.5 43308.0 43450.0 43610.0 44182.8 46457.1 7766.6 7966.0 7979.0 8007.2 8061.6 10548.4 11465.8 12172.5 12339.4 12528.7 10033.5 10692.9 10803.8 11039.9 11147.1 10430.6 10563.5 10605.7 10750.9 11023.6 9685.2 10265.5 10744.7 10903.1 11020.9 8024.5 8074.5 8077.7 8093.1 8132.8 9522.8 9980.9 10212.3 10516.5 10656.0 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | [#3] mootools.html Cycles:180 Average:5441.51 Median:6495.43 stddev:2882.67 (44.4%) stddev-sans-first:2874.73 01:27:23 INFO - PROCESS | 7223 | Values: 1398.0 1418.5 1560.4 1739.0 1750.6 7270.2 7472.9 7499.3 7773.7 7924.9 7694.7 7738.5 7752.3 7800.1 7815.4 2236.6 2237.5 2245.9 2253.5 2261.2 2237.1 2270.3 2270.5 2274.6 2281.8 1993.3 2202.2 2245.9 2261.0 2286.8 2202.7 2217.3 2229.6 2237.5 2238.5 2217.1 2229.4 2231.8 2240.0 2245.0 7719.3 7744.9 7749.1 7751.3 7766.6 4612.0 4739.9 4748.9 4751.3 4763.8 2994.1 3024.0 3082.0 3089.2 3112.5 992.1 993.1 1033.6 1035.0 1040.6 10757.2 10817.4 10846.2 10868.7 10881.8 4098.2 4127.5 4148.0 4197.0 4202.6 8526.9 8561.7 8576.6 8590.2 8602.7 4642.9 4662.9 4666.6 4670.4 4673.1 4316.4 4316.9 4341.4 4369.8 4385.8 3439.4 3441.5 3442.7 3475.2 3496.0 1069.5 1073.4 1080.2 1088.2 1091.0 899.3 1058.2 1096.3 1147.1 1267.4 7275.9 7306.2 7400.9 7414.1 7445.3 595.7 599.3 632.7 635.3 751.7 5508.1 5561.2 5600.4 5672.7 5693.5 9319.1 9769.3 9771.9 9808.3 9856.4 9358.5 9450.7 9583.2 9588.4 9618.9 7484.6 7545.0 7568.5 7569.1 7575.9 7113.0 7173.4 7180.0 7211.2 7242.6 8260.9 8466.6 8539.6 8542.1 8622.9 8660.3 8816.3 8860.5 8899.4 8984.4 6494.5 6558.6 6565.9 6569.2 6589.3 7541.8 7556.5 7611.7 7636.0 7678.6 7147.5 7205.2 7224.6 7365.6 7396.6 6304.9 6857.3 6908.2 7018.8 7052.5 6745.8 7036.2 7039.6 7046.4 7055.3 6410.2 6522.5 6538.2 6544.3 6558.6 6212.2 6229.6 6496.4 6499.6 6506.2 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | [#4] prototype.html Cycles:180 Average:5610.40 Median:6365.96 stddev:1729.91 (27.2%) stddev-sans-first:1688.81 01:27:23 INFO - PROCESS | 7223 | Values: 333.1 336.8 341.3 346.4 349.0 6212.5 6267.9 6333.7 6349.1 6383.5 6332.7 6353.6 6365.2 6391.3 6407.4 4842.8 4845.6 4855.9 4859.2 4868.8 4870.5 4871.0 4889.3 4893.0 4898.5 4591.7 4720.8 4731.8 4734.0 4769.5 4729.0 4729.5 4741.3 4742.0 4748.7 4104.5 4106.4 4112.1 4115.6 4117.8 5859.2 5978.0 5979.3 5985.5 5986.0 5528.6 5530.0 5530.4 5532.1 5532.6 6612.9 6645.7 6648.2 6662.8 6666.8 4386.8 4528.2 4540.1 4541.3 4544.8 6972.4 7002.1 7006.0 7019.0 7047.8 4630.8 4634.5 4639.9 4641.8 4647.1 4689.4 4695.5 4697.5 4698.2 4706.8 5346.9 5476.1 5501.7 5503.9 5514.9 6700.9 6722.0 6749.2 6751.6 6760.6 1630.7 1655.3 1661.6 1661.9 1663.2 1094.7 1096.0 1097.5 1118.2 1119.3 6346.0 6366.7 6375.1 6383.3 6388.8 6923.5 6940.6 6953.4 6961.9 6969.2 6150.9 6323.5 6352.8 6371.2 6375.5 3745.5 3785.7 3810.8 3830.0 3846.1 7302.2 7362.5 7374.9 7375.5 7398.5 7009.0 7196.1 7197.8 7202.0 7216.7 7353.2 7358.4 7365.3 7378.3 7387.1 7001.6 7008.0 7010.8 7014.5 7034.8 6687.6 6794.0 6884.8 6902.2 6907.4 7293.5 7310.9 7324.5 7330.6 7370.6 4638.2 4661.9 4678.4 4679.2 4681.6 6857.0 6956.4 7043.0 7050.9 7053.8 6729.7 6733.6 6739.8 6761.4 6789.7 6632.2 6691.6 6741.8 6777.9 6791.0 6621.6 6627.2 6633.2 6643.5 6668.4 6757.5 6776.3 6781.4 6808.7 6812.8 6534.1 6634.2 6634.9 6660.6 6667.8 01:27:23 INFO - PROCESS | 7223 | 01:27:23 INFO - PROCESS | 7223 | [#5] yui.html Cycles:180 Average:13493.66 Median:48500.02 stddev:15639.72 (32.2%) stddev-sans-first:15654.10 01:27:23 INFO - PROCESS | 7223 | Values: 702.3 727.5 743.4 772.4 786.7 13499.8 13548.4 13560.5 13568.7 13682.9 12788.4 12853.2 12894.4 12990.5 13017.4 676.3 814.0 832.0 843.8 861.1 842.2 842.6 842.9 848.9 849.3 899.4 901.6 902.2 904.0 905.5 892.0 893.5 893.9 895.3 899.0 656.9 658.2 662.3 662.5 665.8 13224.2 13251.9 13269.8 13313.7 13353.4 12322.8 12341.4 12652.7 12664.9 12717.0 10145.1 10165.0 10306.2 10830.9 11041.3 3591.0 3603.4 3646.8 3657.3 3742.0 47433.3 48320.3 48487.0 48513.0 48607.0 8643.2 8758.5 8770.6 8904.6 8957.6 17286.2 17802.6 17804.7 17837.0 17855.6 7303.8 7342.6 7460.5 7551.0 7574.8 4073.7 4141.3 4142.3 4278.9 4356.9 3116.6 3169.4 3205.1 3220.7 3232.1 590.3 591.5 593.4 597.7 616.5 522.7 600.6 609.5 631.9 669.3 7857.0 7862.3 7916.3 8328.5 8394.2 496.4 613.8 615.2 622.3 624.4 3865.7 3922.3 3926.6 3990.3 4085.4 55586.4 56838.1 57121.4 57168.1 57381.4 49394.3 49421.0 49992.5 50035.2 50411.0 44298.1 44359.8 44662.6 45035.8 45044.1 7986.7 8339.0 8382.6 8495.8 8526.1 34871.0 34945.0 35045.5 35088.0 35542.3 39929.8 41355.0 43901.1 43930.6 44109.8 9968.2 9988.5 10029.9 10657.4 10799.8 11499.1 11731.8 11945.8 12002.3 12334.9 10615.3 10658.6 10713.0 11001.6 11005.2 10808.6 10811.7 10944.1 10945.5 11074.6 10754.9 10903.5 10904.5 10959.7 10996.4 9290.0 9332.3 9394.9 9563.8 9924.7 8566.7 9333.4 9396.3 9459.0 9527.0 01:27:23 INFO - PROCESS | 7223 | -------- Summary: end -------- 01:27:23 INFO - PROCESS | 7223 | 01:27:24 INFO - TEST-INFO | 7223: exit 0 01:27:24 INFO - TEST-OK | dromaeo_css | took 1111025ms 01:27:24 INFO - TEST-START | kraken 01:27:24 INFO - operating with platform_type : linux_ 01:27:24 INFO - Initialising browser for kraken test... 01:27:24 INFO - TEST-INFO | started process 7459 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprHYiAQ/profile http://localhost:49030/getInfo.html) 01:27:27 INFO - PROCESS | 7459 | 01:27:27 INFO - PROCESS | 7459 | (process:7529): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:27:28 INFO - PROCESS | 7459 | __metrics Screen width/height:1600/1200 01:27:28 INFO - PROCESS | 7459 | colorDepth:24 01:27:28 INFO - PROCESS | 7459 | Browser inner width/height: 1024/697 01:27:28 INFO - PROCESS | 7459 | __metrics 01:27:29 INFO - TEST-INFO | 7459: exit 0 01:27:29 INFO - Browser initialized. 01:27:29 INFO - Running cycle 1/1 for kraken test... 01:27:29 INFO - TEST-INFO | started process 7580 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprHYiAQ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:27:31 INFO - PROCESS | 7580 | 01:27:31 INFO - PROCESS | 7580 | (process:7636): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:27:41 INFO - PROCESS | 7580 | RSS: Main: 158527488 01:27:41 INFO - PROCESS | 7580 | 01:27:44 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49030/tests/kraken/driver.html?testName=audio-beat-detection) 01:27:44 INFO - PROCESS | 7580 | RSS: Main: 163123200 01:27:44 INFO - PROCESS | 7580 | 01:27:47 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49030/tests/kraken/driver.html?testName=audio-dft) 01:27:47 INFO - PROCESS | 7580 | RSS: Main: 165486592 01:27:47 INFO - PROCESS | 7580 | 01:27:50 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49030/tests/kraken/driver.html?testName=audio-fft) 01:27:51 INFO - PROCESS | 7580 | RSS: Main: 158117888 01:27:51 INFO - PROCESS | 7580 | 01:27:53 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49030/tests/kraken/driver.html?testName=audio-oscillator) 01:27:54 INFO - PROCESS | 7580 | RSS: Main: 159752192 01:27:54 INFO - PROCESS | 7580 | 01:27:56 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49030/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:27:56 INFO - PROCESS | 7580 | RSS: Main: 157622272 01:27:56 INFO - PROCESS | 7580 | 01:27:59 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49030/tests/kraken/driver.html?testName=imaging-darkroom) 01:28:00 INFO - PROCESS | 7580 | RSS: Main: 159494144 01:28:00 INFO - PROCESS | 7580 | 01:28:03 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49030/tests/kraken/driver.html?testName=imaging-desaturate) 01:28:04 INFO - PROCESS | 7580 | RSS: Main: 160165888 01:28:04 INFO - PROCESS | 7580 | 01:28:07 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49030/tests/kraken/driver.html?testName=json-parse-financial) 01:28:07 INFO - PROCESS | 7580 | RSS: Main: 161185792 01:28:07 INFO - PROCESS | 7580 | 01:28:09 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49030/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:28:10 INFO - PROCESS | 7580 | RSS: Main: 161153024 01:28:10 INFO - PROCESS | 7580 | 01:28:11 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:28:12 INFO - PROCESS | 7580 | RSS: Main: 160890880 01:28:12 INFO - PROCESS | 7580 | 01:28:14 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:28:15 INFO - PROCESS | 7580 | RSS: Main: 162717696 01:28:15 INFO - PROCESS | 7580 | 01:28:17 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:28:18 INFO - PROCESS | 7580 | RSS: Main: 161366016 01:28:18 INFO - PROCESS | 7580 | 01:28:20 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:28:21 INFO - PROCESS | 7580 | RSS: Main: 163897344 01:28:21 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | Cycle 1(1): loaded http://localhost:49030/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49030/tests/kraken/driver.html?testName=ai-astar) 01:28:23 INFO - PROCESS | 7580 | RSS: Main: 164712448 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | __start_tp_report 01:28:23 INFO - PROCESS | 7580 | _x_x_mozilla_page_load 01:28:23 INFO - PROCESS | 7580 | _x_x_mozilla_page_load_details 01:28:23 INFO - PROCESS | 7580 | |i|pagename|runs| 01:28:23 INFO - PROCESS | 7580 | |0;ai-astar;115;111;113;113;113;125;114;113;113;114 01:28:23 INFO - PROCESS | 7580 | |1;audio-beat-detection;157;135;149;166;128;154;164;132;168;135 01:28:23 INFO - PROCESS | 7580 | |2;audio-dft;163;163;163;164;163;163;159;168;169;162 01:28:23 INFO - PROCESS | 7580 | |3;audio-fft;75;73;73;147;74;74;73;74;95;73 01:28:23 INFO - PROCESS | 7580 | |4;audio-oscillator;96;97;150;96;96;97;139;96;96;144 01:28:23 INFO - PROCESS | 7580 | |5;imaging-gaussian-blur;120;116;116;116;115;116;116;116;114;116 01:28:23 INFO - PROCESS | 7580 | |6;imaging-darkroom;147;147;147;148;150;147;147;147;148;147 01:28:23 INFO - PROCESS | 7580 | |7;imaging-desaturate;97;97;96;97;98;96;96;96;96;96 01:28:23 INFO - PROCESS | 7580 | |8;json-parse-financial;59;59;61;57;57;57;57;68;55;56 01:28:23 INFO - PROCESS | 7580 | |9;json-stringify-tinderbox;67;67;66;67;67;67;67;68;68;67 01:28:23 INFO - PROCESS | 7580 | |10;stanford-crypto-aes;83;85;91;86;86;91;93;84;92;86 01:28:23 INFO - PROCESS | 7580 | |11;stanford-crypto-ccm;123;117;119;119;123;118;127;120;125;119 01:28:23 INFO - PROCESS | 7580 | |12;stanford-crypto-pbkdf2;157;155;163;142;153;156;153;153;159;142 01:28:23 INFO - PROCESS | 7580 | |13;stanford-crypto-sha256-iterative;73;75;71;72;74;70;68;69;70;69 01:28:23 INFO - PROCESS | 7580 | __end_tp_report 01:28:23 INFO - PROCESS | 7580 | __start_cc_report 01:28:23 INFO - PROCESS | 7580 | _x_x_mozilla_cycle_collect,756 01:28:23 INFO - PROCESS | 7580 | __end_cc_report 01:28:23 INFO - PROCESS | 7580 | __startTimestamp1455701303471__endTimestamp 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | ------- Summary: start ------- 01:28:23 INFO - PROCESS | 7580 | Number of tests: 14 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#0] ai-astar Cycles:10 Average:114.40 Median:113.50 stddev:3.86 (3.4%) stddev-sans-first:4.09 01:28:23 INFO - PROCESS | 7580 | Values: 115.0 111.0 113.0 113.0 113.0 125.0 114.0 113.0 113.0 114.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#1] audio-beat-detection Cycles:10 Average:148.80 Median:155.50 stddev:15.22 (9.8%) stddev-sans-first:15.85 01:28:23 INFO - PROCESS | 7580 | Values: 157.0 135.0 149.0 166.0 128.0 154.0 164.0 132.0 168.0 135.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:2.87 (1.8%) stddev-sans-first:3.03 01:28:23 INFO - PROCESS | 7580 | Values: 163.0 163.0 163.0 164.0 163.0 163.0 159.0 168.0 169.0 162.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#3] audio-fft Cycles:10 Average:83.10 Median:74.00 stddev:23.44 (31.7%) stddev-sans-first:24.68 01:28:23 INFO - PROCESS | 7580 | Values: 75.0 73.0 73.0 147.0 74.0 74.0 73.0 74.0 95.0 73.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:96.00 stddev:23.36 (24.3%) stddev-sans-first:24.16 01:28:23 INFO - PROCESS | 7580 | Values: 96.0 97.0 150.0 96.0 96.0 97.0 139.0 96.0 96.0 144.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.00 stddev:1.52 (1.3%) stddev-sans-first:0.71 01:28:23 INFO - PROCESS | 7580 | Values: 120.0 116.0 116.0 116.0 115.0 116.0 116.0 116.0 114.0 116.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 01:28:23 INFO - PROCESS | 7580 | Values: 147.0 147.0 147.0 148.0 150.0 147.0 147.0 147.0 148.0 147.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 01:28:23 INFO - PROCESS | 7580 | Values: 97.0 97.0 96.0 97.0 98.0 96.0 96.0 96.0 96.0 96.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.72 (6.4%) stddev-sans-first:3.94 01:28:23 INFO - PROCESS | 7580 | Values: 59.0 59.0 61.0 57.0 57.0 57.0 57.0 68.0 55.0 56.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 01:28:23 INFO - PROCESS | 7580 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 67.0 68.0 68.0 67.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:88.50 stddev:3.65 (4.1%) stddev-sans-first:3.46 01:28:23 INFO - PROCESS | 7580 | Values: 83.0 85.0 91.0 86.0 86.0 91.0 93.0 84.0 92.0 86.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:121.50 stddev:3.30 (2.7%) stddev-sans-first:3.42 01:28:23 INFO - PROCESS | 7580 | Values: 123.0 117.0 119.0 119.0 123.0 118.0 127.0 120.0 125.0 119.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:155.50 stddev:6.72 (4.3%) stddev-sans-first:6.99 01:28:23 INFO - PROCESS | 7580 | Values: 157.0 155.0 163.0 142.0 153.0 156.0 153.0 153.0 159.0 142.0 01:28:23 INFO - PROCESS | 7580 | 01:28:23 INFO - PROCESS | 7580 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:2.33 (3.3%) stddev-sans-first:2.37 01:28:23 INFO - PROCESS | 7580 | Values: 73.0 75.0 71.0 72.0 74.0 70.0 68.0 69.0 70.0 69.0 01:28:23 INFO - PROCESS | 7580 | -------- Summary: end -------- 01:28:23 INFO - PROCESS | 7580 | 01:28:24 INFO - TEST-INFO | 7580: exit 0 01:28:24 INFO - TEST-OK | kraken | took 60266ms 01:28:24 INFO - SUITE-END | took 1171s 01:28:24 INFO - Completed test suite (00:19:31) 01:28:24 INFO - Working with test: dromaeo_css 01:28:24 INFO - Generating results file: dromaeo_css 01:28:24 INFO - Working with test: kraken 01:28:24 INFO - Generating results file: kraken 01:28:24 INFO - javascript benchmark 01:28:24 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:28:24 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 01:28:24 INFO - process_Request line: dromaeo_css 7026.34 graph.html#tests=[[72,63,43]] 01:28:24 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:28:24 INFO - process_Request line: kraken 1539.60 graph.html#tests=[[232,63,43]] 01:28:24 INFO - RETURN: dromaeo_css: 7026.34 01:28:24 INFO - RETURN: kraken: 1539.60 01:28:24 INFO - javascript benchmark 01:28:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3205.1346136543148, 3229.208843833261, 3245.4158251514746, 3267.7712560120785, 3277.3772983133213, 5171.689698618076, 5194.091034069037, 5230.529252367286, 5231.607629427798, 5243.55429788468, 5343.919841202375, 5381.730913454331, 5406.0, 5409.9459005410035, 5420.728963551826, 4894.706317620954, 4952.975235123819, 4992.375953005874, 4999.650024498286, 5080.822171224008, 4831.975840120812, 4982.725950072744, 4995.375578052744, 5027.522385373383, 5045.0666626674, 4801.159797035505, 4802.0, 4879.0, 4936.062148191868, 4937.0, 4832.782524786393, 4880.780364883589, 4883.8534843954385, 4887.242477415971, 4927.285543596195, 4768.451628062782, 4841.612670986313, 4847.830325938575, 4861.222204447272, 4917.0903382874285, 5126.154184559543, 5188.870278243036, 5213.061648903196, 5235.39792923811, 5249.055170069386, 5670.68811215383, 5674.517665998395, 5679.403662615448, 5680.488756011979, 5700.800471983503, 5607.523360514361, 5735.1970724098655, 5775.480206781368, 5790.942090579125, 5900.468957793776, 5461.453854614547, 5462.481064298885, 5472.042392581322, 5478.233047373371, 5483.369412517612, 5893.5874488785375, 5901.996660567714, 5927.110933360031, 5939.881202375928, 5948.583599148104, 5566.666000040011, 5629.24005259293, 5642.971785141048, 5644.915326270109, 5646.689432081275, 5594.440555944373, 5642.210090587321, 5672.97163514188, 5798.188253644493, 5848.0, 5569.805056822992, 5577.3028371453565, 5587.329520457572, 5611.2144299798065, 5625.324961004706, 5567.610267281251, 5593.328800543961, 5612.831615051555, 5627.943720562742, 5634.126710359901, 4249.553796851348, 4344.717593356485, 4383.736975781463, 4400.207962566705, 4439.889002774957, 3940.2316548273384, 3946.901327466779, 3962.108525581721, 3978.403239514096, 3980.4029395590314, 5255.658382205144, 5310.007974481674, 5358.705271210121, 5392.487713667196, 5396.595255355864, 5667.4615911488345, 5708.40061793514, 5727.05503591911, 5755.625884317506, 5809.796657116981, 5355.973220133875, 5367.302250707383, 5381.0, 5382.2464854920345, 5384.488473595002, 4759.928601070987, 4825.927611085836, 4847.660663753574, 4854.781534830941, 4881.365422495124, 5963.194968679346, 5965.105234214816, 5977.282726072899, 5984.192134061933, 6016.368281330485, 5695.373508914099, 5717.485426311652, 5720.513756330759, 5725.312962444534, 5727.799527016535, 5909.261342332208, 5947.167396564398, 5985.431384018511, 6005.309389420273, 6058.697065146637, 5618.494335509824, 5665.716714164358, 5666.546676265972, 5672.2342483765815, 5673.631213971079, 5718.313802343745, 5745.655260684205, 5758.884822303614, 5763.6541807491685, 5766.163906233656, 5504.4770746778995, 5557.972210138923, 5579.74891129892, 5628.943710563006, 5664.348599911063, 5582.358028826737, 5584.301962254718, 5586.273784408001, 5598.188262701804, 5630.887382252414, 5296.947030529645, 5482.862928426821, 5507.476789704971, 5529.281193444826, 5556.72216389187, 5651.915221271766, 5668.433156684298, 5670.886582268249, 5692.800751973661, 5693.829185124453, 5463.07127788269, 5525.751341189576, 5555.972220139035, 5558.02734521449, 5559.16612508127], "unit": "score", "name": "dojo.html", "value": 5282.553046915909}, {"lowerIsBetter": false, "replicates": [494.1352632892438, 529.8966701493208, 530.6603773584906, 546.6419495230624, 585.8593937455012, 36058.819705901464, 36474.0, 36623.08442288938, 36661.45007824882, 36679.08302292441, 39591.40612890802, 39687.0, 39737.403938940864, 40212.59787402125, 40238.0, 8458.069612342653, 8593.95703021484, 8603.827923441528, 8645.69740059098, 8669.826603467958, 8466.407351485399, 8578.142185781404, 8596.8710469343, 8631.482111073325, 8638.09300023498, 8791.560421978907, 8861.955690221539, 8864.0, 8882.822343553125, 8888.422252553595, 8498.78753031173, 8564.828703425928, 8566.614502347378, 8822.11778822119, 8842.778930526723, 8734.213920747163, 8822.382433229677, 8842.42524235929, 8862.955685221532, 8884.422512536665, 39330.213395731924, 39965.801025968976, 40035.799821001, 40040.799796000836, 40124.197516049804, 3226.451503244454, 3295.802251864872, 3336.0492259705866, 3433.914152146216, 3598.3702852001056, 29460.11619651414, 30105.69894301051, 30442.54336184959, 30595.0, 31341.529877051864, 3609.1338078860886, 3707.8331475083414, 3737.439384092408, 3755.117547376364, 3755.1191432262776, 253071.0, 254207.0, 254234.0, 254381.0, 255360.0, 53956.0, 60640.0, 61067.389326107055, 66993.66012679816, 68666.96999544911, 54537.72731136398, 54548.18177727337, 54645.1803222952, 54805.0, 55135.172972405446, 14267.500637477846, 14379.496717615042, 14391.92804035994, 14400.639984000274, 14402.0, 11776.941115294369, 11975.46110425033, 11978.700532486757, 12001.579944701894, 12007.819882701766, 20635.4841128973, 20963.0, 20965.0, 20989.580208395746, 21210.893945530483, 7771.92228077712, 7802.687892484237, 7854.528728276322, 7876.763697089096, 7998.520088794575, 887.2857349833317, 926.1942110364026, 1000.5247507434057, 1022.3508072374096, 1063.5320458998017, 28844.567331490045, 30400.847995760323, 30783.0, 30868.845655771576, 31138.377232455223, 985.393982700634, 1026.7022563456662, 1034.6689059500889, 1051.3849398102043, 1112.6328311657296, 13935.0, 13964.0, 13973.79039314411, 13984.790228146587, 14014.0, 383973.0, 392389.0, 393748.0, 393890.0, 397636.0, 53242.7337863316, 53530.732346338795, 53891.0, 53900.73049634727, 53937.0, 1283.2108253424076, 1302.5636411802152, 1308.3458270864567, 1311.5475161069417, 1314.0538812055304, 26810.11951078356, 26938.730612693624, 27702.307442313297, 27721.722782771914, 27738.306542335795, 44039.77980110207, 44428.0, 44702.776486117364, 44723.77638111789, 44922.3261651069, 296853.0, 298301.0, 299049.0, 299086.0, 299815.0, 31931.201719956258, 44096.779516102215, 44200.0, 44764.77617611891, 44889.551104488535, 37885.0, 38851.417228741026, 38859.0, 39537.80231098826, 39711.0, 33607.15982100467, 33953.0, 34739.478907816905, 35196.47205291872, 36610.8169459151, 36613.26773464462, 36641.0, 39088.6091139085, 41712.58287417208, 42712.0, 35287.64712352843, 35492.112697182776, 35577.46633800443, 38658.2268354637, 39331.803340984254, 29298.267543311587, 30849.845750771103, 31189.0, 31453.0, 33033.0, 25099.74900250974, 25115.246542603752, 25307.74692253054, 25495.617565736156, 25626.359341016625], "unit": "score", "name": "ext.html", "value": 18499.45953603874}, {"lowerIsBetter": false, "replicates": [364.71187761668284, 366.5399923096513, 371.05936451096466, 373.82430257778833, 374.7863717680923, 16195.838041619594, 17076.231569579366, 17264.0, 17705.7344139838, 17987.37044203453, 10814.0, 11911.702207444796, 16090.1954902255, 16544.503664890042, 16639.41762038329, 5007.774650140753, 5549.833504994856, 5551.333839939213, 5586.190002449643, 5589.496945274925, 4685.180093483644, 5127.9230811537855, 5450.5367043801325, 5531.0, 5561.388247292794, 5059.064073146461, 5132.6407151499225, 5150.690958542481, 5254.789808407678, 5295.0998330283755, 5157.948420515821, 5173.405058418292, 5207.531322181003, 5230.267762513251, 5529.115341545334, 5412.0, 5416.83749487516, 5422.91865622016, 5431.83704488866, 5437.13005919051, 15145.318460669187, 19648.901755491275, 20510.282140125026, 20583.176672933216, 20712.48218794542, 1835.9541011474687, 1934.2359767891603, 1943.7473128493348, 2338.8012018978407, 2445.9266222013366, 9510.762230944212, 9599.568019439143, 11190.776184476346, 12345.753084938251, 12774.0, 1871.2982631513182, 1900.8194221548931, 1951.7950615185484, 1985.0967809646577, 1994.2621230144794, 65788.67105664441, 69746.0, 70026.0, 70938.64530677313, 71172.28827711761, 15193.316300766492, 15311.46409875649, 15698.843011569737, 15741.291641876143, 15818.209089545477, 24073.157439489532, 24074.0, 24341.756582434304, 24557.263282101565, 24561.631575526382, 8662.956685216534, 8713.825723485621, 8759.649614015496, 8907.376483646083, 8910.643574257087, 7380.114386273574, 7382.114146302478, 7385.778426647209, 7448.702051917971, 7454.701811927571, 7668.463207575416, 7774.92225077742, 7775.105862825847, 7828.0, 7835.882461763078, 1846.6122114355867, 1908.4465505003393, 3120.3135310231714, 3220.903372898817, 3240.157559034668, 792.4611264340303, 861.2722249698994, 882.7263548300048, 964.3779762053437, 1004.7387679203459, 15892.205389730467, 16037.438689645807, 16617.750733739005, 17149.828501715074, 17868.195931183127, 875.9036505984336, 906.1482206725657, 915.2312057871287, 915.7481692534473, 952.9952350238204, 9816.754581135528, 10031.448270345056, 10051.0, 10117.67293522494, 10133.493325333704, 482074.0, 567381.0, 573696.0, 575024.0, 575167.0, 75237.62381188168, 77533.0, 78143.0, 80312.59843700744, 80348.19651803524, 1156.1444531046964, 1161.268400907423, 1166.1079274355125, 1168.9006434452997, 1172.935488548121, 15373.615659608151, 15520.84479155194, 15607.375704972128, 15614.765778513105, 15683.686326273639, 34645.826770865984, 35650.28699426049, 35731.0, 35798.28403431969, 36611.450828237066, 43308.0, 43450.0, 43610.0, 44182.77908610436, 46457.07085858331, 7766.5728384939375, 7966.0, 7979.0, 8007.1592482788465, 8061.556614386265, 10548.36709797384, 11465.770684586429, 12172.513099476277, 12339.444724987217, 12528.686782830502, 10033.548490317808, 10692.89307106919, 10803.837942431028, 11039.889601103887, 11147.108231341635, 10430.582776688847, 10563.524641391003, 10605.681829545127, 10750.946245268724, 11023.61417350389, 9685.225181985283, 10265.538050787583, 10744.677659670222, 10903.073238774476, 11020.944895275472, 8024.478408903403, 8074.475159114639, 8077.717279895175, 8093.0692970309165, 8132.83734325322, 9522.8096487939, 9980.900190998287, 10212.285140040125, 10516.526756295832, 10656.0], "unit": "score", "name": "jquery.html", "value": 8963.69452529982}, {"lowerIsBetter": false, "replicates": [1397.9930100349497, 1418.546065259117, 1560.42264362186, 1739.0435260606664, 1750.6498700259942, 7270.163931147919, 7472.850542989144, 7499.287567681075, 7773.7279195228175, 7924.92075079249, 7694.692212311501, 7738.496997695146, 7752.263534964183, 7800.1419843817275, 7815.413843961712, 2236.563870045342, 2237.474193564511, 2245.932622021342, 2253.4704344479032, 2261.2198791416936, 2237.1163390460756, 2270.2735124760084, 2270.545890821834, 2274.55646149001, 2281.7946384825364, 1993.252530301137, 2202.196198387585, 2245.8877056147207, 2260.9660855087104, 2286.7827556382117, 2202.702635144251, 2217.3458829645215, 2229.554089182154, 2237.451824303048, 2238.507528343762, 2217.1463986365206, 2229.3534874886263, 2231.843770936035, 2239.9776002239932, 2245.0346351069034, 7719.3052625264, 7744.922550774477, 7749.108852481981, 7751.263629955145, 7766.57283849388, 4612.031473390592, 4739.857804265877, 4748.857534273943, 4751.3348131261655, 4763.809447622091, 2994.1017694691504, 3024.010382868263, 3081.9691803081905, 3089.1813669377634, 3112.517559778238, 992.1368409483796, 993.126049076815, 1033.5504055735703, 1034.963776267827, 1040.5733649203867, 10757.246992710514, 10817.35095894241, 10846.240763146583, 10868.728281793019, 10881.83677244842, 4098.180363927167, 4127.484064491939, 4148.0, 4196.979015104905, 4202.621764041251, 8526.914730852735, 8561.743147705578, 8576.571171441528, 8590.1839325264, 8602.655893764304, 4642.907141857144, 4662.860114196579, 4666.626669866402, 4670.439547254351, 4673.088747694235, 4316.374125751749, 4316.935245971313, 4341.39220509129, 4369.847055353048, 4385.846495372647, 3439.3809114359656, 3441.4665726812386, 3442.7417943654327, 3475.218075932895, 3495.9825200873834, 1069.5187165775433, 1073.4042606353394, 1080.1628737728167, 1088.1566785741113, 1091.0344345254348, 899.3075331994328, 1058.1746237934424, 1096.2600244834864, 1147.0566328177504, 1267.4423253768311, 7275.854482910312, 7306.159791623925, 7400.851982960311, 7414.110306763115, 7445.292697193866, 595.684287327717, 599.3317451042057, 632.6804963493498, 635.3329004545209, 751.7483390155439, 5508.14623733314, 5561.249231353796, 5600.411956744565, 5672.688002159921, 5693.544516438675, 9319.114684105134, 9769.31614786958, 9771.853422198672, 9808.313418060667, 9856.359336643096, 9358.485283309346, 9450.669226577036, 9583.233341332676, 9588.37675551087, 9618.903810961801, 7484.625768711543, 7544.962275188699, 7568.5458872467825, 7569.129550101698, 7575.924240757522, 7112.964435177998, 7173.390261827594, 7179.964100179465, 7211.2428195038765, 7242.637868106468, 8260.917390826015, 8466.57667116654, 8539.573021348784, 8542.145785421408, 8622.913770862211, 8660.307175426076, 8816.338774591803, 8860.512671803113, 8899.421537600294, 8984.416012959136, 6494.512911531749, 6558.573692709959, 6565.934340656723, 6569.178852643419, 6589.341065893373, 7541.849163016818, 7556.508826926232, 7611.657475413509, 7636.0, 7678.616069196406, 7147.499675022698, 7205.171405288459, 7224.566526008456, 7365.558066516026, 7396.593187374746, 6304.873902521832, 6857.314268573103, 6908.205556361083, 7018.841891087914, 7052.541584796972, 6745.831354216184, 7036.19083805369, 7039.627272681778, 7046.436285097282, 7055.2591977841585, 6410.166678331787, 6522.510811689048, 6538.1827271591055, 6544.280129185881, 6558.606483610808, 6212.223472065992, 6229.625506877793, 6496.350364963466, 6499.6425196612745, 6506.186726659168], "unit": "score", "name": "mootools.html", "value": 4390.828083110936}, {"lowerIsBetter": false, "replicates": [333.05246573498397, 336.8484182118047, 341.2918194745901, 346.4474163708887, 348.9738269629777, 6212.471939885115, 6267.905981410283, 6333.7149828257725, 6349.142865713127, 6383.489320854326, 6332.715027823748, 6353.618782873031, 6365.204349456318, 6391.328910464404, 6407.359264073591, 4842.83050093245, 4845.563899249085, 4855.902881942359, 4859.198232291667, 4868.805247790084, 4870.537298956593, 4871.0, 4889.291052797343, 4892.951070489303, 4898.53463920927, 4591.7244965302025, 4720.787564559603, 4731.834385796497, 4733.952660473403, 4769.4515130760055, 4729.0, 4729.503402142795, 4741.265103908882, 4741.952580474185, 4748.667593268473, 4104.486939132608, 4106.445629839964, 4112.074783173762, 4115.567865374122, 4117.773522456264, 5859.1504231886565, 5977.970110149421, 5979.312379076375, 5985.521158307325, 5986.042233242704, 5528.612997090206, 5529.972350138264, 5530.446955304437, 5532.114861622121, 5532.612717109763, 6612.93387066128, 6645.734170633169, 6648.235452922928, 6662.800115996528, 6666.833329166761, 4386.758728269944, 4528.230200865861, 4540.069285796404, 4541.296099104644, 4544.840930567414, 6972.407345375649, 7002.054722612433, 7006.01915731798, 7019.034670292326, 7047.823804404879, 4630.814767409333, 4634.490206077328, 4639.86080417588, 4641.791119399635, 4647.140279048387, 4689.437267527918, 4695.460022097434, 4697.459792123881, 4698.2247929092, 4706.764661766898, 5346.946530534723, 5476.096444086681, 5501.669899806025, 5503.862403439946, 5514.889702205934, 6700.894352431794, 6721.966390168018, 6749.156355455568, 6751.628660423724, 6760.594364338155, 1630.7227771278674, 1655.337864854068, 1661.6261341198376, 1661.900285982845, 1663.1767275198854, 1094.6661268313242, 1095.9780804384027, 1097.5390336058874, 1118.1837258800958, 1119.2501024313729, 6346.048092786026, 6366.713497892606, 6375.139356186855, 6383.329750376237, 6388.776392826228, 6923.4807389446, 6940.583564986117, 6953.374196322356, 6961.895571566431, 6969.23338432772, 6150.938490615126, 6323.52573556985, 6352.809415717444, 6371.23545174582, 6375.521835862236, 3745.4756334113245, 3785.6971442284553, 3810.7523011004196, 3830.042489377656, 3846.076941534068, 7302.1967583565765, 7362.484626076231, 7374.926250737424, 7375.520591161558, 7398.482106252618, 7009.018737376771, 7196.10048743907, 7197.820054498679, 7202.0, 7216.67524961378, 7353.227911069261, 7358.41132709382, 7365.2634736525915, 7378.29906158914, 7387.1135463744695, 7001.614911179934, 7008.018877357276, 7010.824729381602, 7014.473914456538, 7034.824129396806, 6687.598744075371, 6794.0, 6884.759033433806, 6902.240753517009, 6907.412869905913, 7293.489455738048, 7310.8903366448485, 7324.487285889936, 7330.560166390033, 7370.6314684266645, 4638.188317044436, 4661.86014419568, 4678.438587369401, 4679.181143299841, 4681.648876334357, 6857.0, 6956.443484521327, 7042.964785176041, 7050.929490705233, 7053.753118641028, 6729.69716362755, 6733.6296503692765, 6739.764108256383, 6761.425278851353, 6789.709955108514, 6632.2372927114, 6691.631960242039, 6741.764038258638, 6777.864442711019, 6791.0, 6621.602703837785, 6627.204735431779, 6633.237177724431, 6643.50173736962, 6668.433183179484, 6757.493188011017, 6776.322367763184, 6781.355771201728, 6808.65956702153, 6812.807758642119, 6534.117894084237, 6634.170728658918, 6634.933650663625, 6660.6336651484635, 6667.833304167435], "unit": "score", "name": "prototype.html", "value": 5041.106907196099}, {"lowerIsBetter": false, "replicates": [702.2977022977022, 727.5343779980814, 743.4201322968086, 772.4013889235841, 786.6538722961893, 13499.79750303745, 13548.390322435489, 13560.525381611646, 13568.728625427499, 13682.863171368295, 12788.424520896559, 12853.164544304615, 12894.355282235898, 12990.480380784757, 13017.414216360263, 676.2898956096079, 814.0353680888137, 832.0348395860802, 843.797488602734, 861.1474640106281, 842.2293601354753, 842.5787106446777, 842.8862103616025, 848.8514509960763, 849.2993280543576, 899.4333569850985, 901.5852707754441, 902.2466240689, 904.0326850270213, 905.4748246017327, 892.0499667853715, 893.5353616119646, 893.8927328720563, 895.2524641924001, 898.9550522473883, 656.8620589676174, 658.2298710508717, 662.3211208511266, 662.5163630549678, 665.7936039827669, 13224.206547607078, 13251.86748132516, 13269.800952985714, 13313.733725325535, 13353.399097040656, 12322.81515777264, 12341.444634991447, 12652.68368290791, 12664.936675316656, 12717.046221533423, 10145.137663298554, 10165.0, 10306.227032972482, 10830.945845270724, 11041.33751974884, 3590.964090359089, 3603.387424137903, 3646.835892384849, 3657.3233951719017, 3741.9896627910584, 47433.28850067252, 48320.27519587174, 48487.03025939497, 48513.0, 48607.0, 8643.154104752259, 8758.518281494451, 8770.605322760492, 8904.643814247487, 8957.552122393985, 17286.22212000438, 17802.5549361267, 17804.732929006077, 17837.0, 17855.553611159565, 7303.817404564822, 7342.596157211405, 7460.515066520658, 7551.0, 7574.848503029909, 4073.6944729145434, 4141.275276826544, 4142.2958097123565, 4278.935815962701, 4356.934645980313, 3116.5792617996735, 3169.397814415254, 3205.086550333144, 3220.6618305077627, 3232.078857525594, 590.2887021139517, 591.4588151841017, 593.3769541980989, 597.6712807955607, 616.5067945643557, 522.6524361299693, 600.5765935015803, 609.5397974529202, 631.9494440444753, 669.2604671837647, 7857.0, 7862.331701805296, 7916.287534121957, 8328.541930193898, 8394.160583941557, 496.42662724553196, 613.8465383654086, 615.227888999303, 622.2949119412866, 624.4411251929498, 3865.7487263327794, 3922.3332033554366, 3926.6269704378037, 3990.3216453203027, 4085.4484644573195, 55586.44413555894, 56838.147427788615, 57121.428785711614, 57168.142477862864, 57381.42618573844, 49394.259086113736, 49421.0, 49992.50007499878, 50035.24947125796, 50411.0, 44298.11403771907, 44359.77820110943, 44662.553374466486, 45035.77482112503, 45044.09911801811, 7986.720464783704, 8338.953465307266, 8382.622781974947, 8495.787605309917, 8526.104759000216, 34871.0, 34945.0, 35045.47431788576, 35088.0, 35542.289154216254, 39929.80035099806, 41355.0, 43901.12197755963, 43930.56069439265, 44109.77945110254, 9968.202543796624, 9988.450635215133, 10029.899701003189, 10657.413842238751, 10799.838002430128, 11499.13756468285, 11731.824022639837, 11945.761084778429, 12002.279863207887, 12334.876651233373, 10615.31000484966, 10658.573657053632, 10713.0, 11001.559937602406, 11005.17461190398, 10808.621698240524, 10811.729706757395, 10944.069754070993, 10945.452727363441, 11074.612388566362, 10754.946225268823, 10903.454827258447, 10904.454777261264, 10959.671209863716, 10996.395198264172, 9290.0, 9332.253419726541, 9394.859077113986, 9563.808723825345, 9924.702258932244, 8566.657333706831, 9333.439993600407, 9396.342256042011, 9458.95270523643, 9526.952365238129], "unit": "score", "name": "yui.html", "value": 6205.461629559457}], "name": "dromaeo_css", "value": 7026.339303806993}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 113.0, 113.0, 113.0, 125.0, 114.0, 113.0, 113.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [157.0, 135.0, 149.0, 166.0, 128.0, 154.0, 164.0, 132.0, 168.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [163.0, 163.0, 163.0, 164.0, 163.0, 163.0, 159.0, 168.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 73.0, 147.0, 74.0, 74.0, 73.0, 74.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 96.0, 96.0, 97.0, 139.0, 96.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 116.0, 116.0, 115.0, 116.0, 116.0, 116.0, 114.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 148.0, 150.0, 147.0, 147.0, 147.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 61.0, 57.0, 57.0, 57.0, 57.0, 68.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 91.0, 86.0, 86.0, 91.0, 93.0, 84.0, 92.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.7}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 119.0, 119.0, 123.0, 118.0, 127.0, 120.0, 125.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [157.0, 155.0, 163.0, 142.0, 153.0, 156.0, 153.0, 153.0, 159.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 153.3}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 71.0, 72.0, 74.0, 70.0, 68.0, 69.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1539.6}]} 01:28:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1539.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7026.34"}}} 01:28:24 INFO - Return code: 0 01:28:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 01:28:24 INFO - # TBPL SUCCESS # 01:28:24 INFO - Running post-action listener: _resource_record_post_action 01:28:24 INFO - Running post-run listener: _resource_record_post_run 01:28:25 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 450560; Write bytes: 370704384; Read time: 192; Write time: 243812 01:28:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 76214272; Read time: 0; Write time: 46624 01:28:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 450560; Write bytes: 294490112; Read time: 192; Write time: 197188 01:28:25 INFO - Running post-run listener: _upload_blobber_files 01:28:25 INFO - Blob upload gear active. 01:28:25 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 01:28:25 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:28:25 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:28:25 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:28:26 INFO - (blobuploader) - INFO - Open directory for files ... 01:28:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:28:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:28:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:32 INFO - (blobuploader) - INFO - Done attempting. 01:28:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:28:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:28:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:28:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:28:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:28:33 INFO - (blobuploader) - INFO - Done attempting. 01:28:33 INFO - (blobuploader) - INFO - Iteration through files over. 01:28:33 INFO - Return code: 0 01:28:33 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 01:28:33 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 01:28:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d1d35b4b32fafdb697e3f8a7756cd9dc6eb47f8a830d1f1fd9797b49528d414fe1ab5a70ed4777f02daac1eb3a0eece1baa7cd5f67efcd272383c47d639ff96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8843b079de9769d4ae658d87f1ba7ac4ab031c6399831573eb7e8daf1bd1cfa9b6a377a6b23d80d23b9a701a531b5bedeed4690034517d77bb3ee2e2a6f1075d"} 01:28:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 01:28:33 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 01:28:33 INFO - Contents: 01:28:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d1d35b4b32fafdb697e3f8a7756cd9dc6eb47f8a830d1f1fd9797b49528d414fe1ab5a70ed4777f02daac1eb3a0eece1baa7cd5f67efcd272383c47d639ff96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8843b079de9769d4ae658d87f1ba7ac4ab031c6399831573eb7e8daf1bd1cfa9b6a377a6b23d80d23b9a701a531b5bedeed4690034517d77bb3ee2e2a6f1075d"} 01:28:33 INFO - Running post-run listener: copy_logs_to_upload_dir 01:28:33 INFO - Copying logs to upload dir... 01:28:33 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 01:28:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.254934 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-02-17 01:28:33.052949) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 01:28:33.056693) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d1d35b4b32fafdb697e3f8a7756cd9dc6eb47f8a830d1f1fd9797b49528d414fe1ab5a70ed4777f02daac1eb3a0eece1baa7cd5f67efcd272383c47d639ff96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8843b079de9769d4ae658d87f1ba7ac4ab031c6399831573eb7e8daf1bd1cfa9b6a377a6b23d80d23b9a701a531b5bedeed4690034517d77bb3ee2e2a6f1075d"} build_url:https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/PhM8pgxZQsegBzJm2ikTDQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d1d35b4b32fafdb697e3f8a7756cd9dc6eb47f8a830d1f1fd9797b49528d414fe1ab5a70ed4777f02daac1eb3a0eece1baa7cd5f67efcd272383c47d639ff96", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8843b079de9769d4ae658d87f1ba7ac4ab031c6399831573eb7e8daf1bd1cfa9b6a377a6b23d80d23b9a701a531b5bedeed4690034517d77bb3ee2e2a6f1075d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-17 01:28:33.084607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:28:33.085449) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1455688809.293139-177600091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-17 01:28:33.167879) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 01:28:33.168602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-17 01:28:33.169251) ========= ========= Total master_lag: 0.27 =========