builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1459982785.55 results: success (0) buildid: 20160406124830 builduid: adabe1ec72be45088989fadf387f5f5e revision: 71f5a85ac2b38dbe441b2e894bea002cf9f902bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.549695) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.550270) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.550613) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003752 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.589370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.589755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.652277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.653049) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004723 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.766410) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.766778) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.767214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:25.767538) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-06 15:46:26-- 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% 229M=0s 2016-04-06 15:46:26 (229 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.391260 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:26.184145) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:26.184538) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022933 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:26.236957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 15:46:26.237367) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 71f5a85ac2b38dbe441b2e894bea002cf9f902bd --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 71f5a85ac2b38dbe441b2e894bea002cf9f902bd --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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-06 15:46:26,905 truncating revision to first 12 chars 2016-04-06 15:46:26,905 Setting DEBUG logging. 2016-04-06 15:46:26,905 attempt 1/10 2016-04-06 15:46:26,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/71f5a85ac2b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 15:46:27,655 unpacking tar archive at: mozilla-aurora-71f5a85ac2b3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.257440 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 15:46:27.517014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:27.517822) ========= echo 71f5a85ac2b38dbe441b2e894bea002cf9f902bd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'71f5a85ac2b38dbe441b2e894bea002cf9f902bd'] 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 71f5a85ac2b38dbe441b2e894bea002cf9f902bd program finished with exit code 0 elapsedTime=0.004775 script_repo_revision: '71f5a85ac2b38dbe441b2e894bea002cf9f902bd' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:27.583704) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:27.584064) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 15:46:27.595986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 15 secs) (at 2016-04-06 15:46:27.596439) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:46:28 INFO - MultiFileLogger online at 20160406 15:46:28 in /builds/slave/test-pgo 15:46:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:46:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:46:28 INFO - {'append_to_log': False, 15:46:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:46:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:46:28 INFO - 'branch': 'Mozilla-Aurora', 15:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:46:28 INFO - 'config_files': ('talos/linux_config.py',), 15:46:28 INFO - 'default_actions': ('clobber', 15:46:28 INFO - 'read-buildbot-config', 15:46:28 INFO - 'download-and-extract', 15:46:28 INFO - 'populate-webroot', 15:46:28 INFO - 'create-virtualenv', 15:46:28 INFO - 'install', 15:46:28 INFO - 'run-tests'), 15:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:46:28 INFO - 'download_minidump_stackwalk': True, 15:46:28 INFO - 'download_symbols': 'ondemand', 15:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:46:28 INFO - 'installer_path': 'installer.exe', 15:46:28 INFO - 'log_level': 'info', 15:46:28 INFO - 'log_name': 'talos', 15:46:28 INFO - 'log_to_console': True, 15:46:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:46:28 INFO - 'opt_config_files': (), 15:46:28 INFO - 'pip_index': False, 15:46:28 INFO - 'sps_profile': False, 15:46:28 INFO - 'sps_profile_interval': 0, 15:46:28 INFO - 'suite': 'dromaeojs-e10s', 15:46:28 INFO - 'system_bits': '32', 15:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:46:28 INFO - 'title': 'talos-linux64-ix-022', 15:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:46:28 INFO - 'use_talos_json': True, 15:46:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:46:28 INFO - 'work_dir': 'build'} 15:46:28 INFO - ##### 15:46:28 INFO - ##### Running clobber step. 15:46:28 INFO - ##### 15:46:28 INFO - Running pre-action listener: _resource_record_pre_action 15:46:28 INFO - Running main action method: clobber 15:46:28 INFO - rmtree: /builds/slave/test-pgo/build 15:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:46:29 INFO - Running post-action listener: _resource_record_post_action 15:46:29 INFO - ##### 15:46:29 INFO - ##### Running read-buildbot-config step. 15:46:29 INFO - ##### 15:46:29 INFO - Running pre-action listener: _resource_record_pre_action 15:46:29 INFO - Running main action method: read_buildbot_config 15:46:29 INFO - Using buildbot properties: 15:46:29 INFO - { 15:46:29 INFO - "project": "", 15:46:29 INFO - "product": "firefox", 15:46:29 INFO - "script_repo_revision": "production", 15:46:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 15:46:29 INFO - "repository": "", 15:46:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 15:46:29 INFO - "buildid": "20160406124830", 15:46:29 INFO - "pgo_build": "True", 15:46:29 INFO - "basedir": "/builds/slave/test-pgo", 15:46:29 INFO - "buildnumber": 176, 15:46:29 INFO - "slavename": "talos-linux64-ix-022", 15:46:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:46:29 INFO - "platform": "ubuntu64_hw", 15:46:29 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:46:29 INFO - "branch": "mozilla-aurora", 15:46:29 INFO - "repo_path": "releases/mozilla-aurora", 15:46:29 INFO - "revision": "71f5a85ac2b38dbe441b2e894bea002cf9f902bd", 15:46:29 INFO - "stage_platform": "linux64-pgo", 15:46:29 INFO - "builduid": "adabe1ec72be45088989fadf387f5f5e", 15:46:29 INFO - "slavebuilddir": "test" 15:46:29 INFO - } 15:46:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 15:46:29 INFO - Running post-action listener: _resource_record_post_action 15:46:29 INFO - ##### 15:46:29 INFO - ##### Running download-and-extract step. 15:46:29 INFO - ##### 15:46:29 INFO - Running pre-action listener: _resource_record_pre_action 15:46:29 INFO - Running main action method: download_and_extract 15:46:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:29 INFO - https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:46:31 INFO - Downloaded 1448 bytes. 15:46:31 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 15:46:31 INFO - Using the following test package requirements: 15:46:31 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:46:31 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:46:31 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:46:31 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'jsshell-linux-x86_64.zip'], 15:46:31 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:46:31 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:46:31 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:46:31 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:46:31 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:46:31 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 15:46:31 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 15:46:31 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:46:31 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:31 INFO - https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:46:36 INFO - Downloaded 23345257 bytes. 15:46:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:46:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:46:37 INFO - Return code: 0 15:46:37 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:37 INFO - https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:46:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:46:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:46:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 15:46:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:46:43 INFO - Downloaded 23345257 bytes. 15:46:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:46:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 15:46:45 INFO - Return code: 0 15:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:45 INFO - https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:46:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:46:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:46:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 15:46:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:51:09 INFO - Downloaded 10845161 bytes. 15:51:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 15:51:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 15:51:09 INFO - Return code: 0 15:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:09 INFO - https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:51:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:51:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:51:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:51:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:51:28 INFO - Downloaded 60568983 bytes. 15:51:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:51:28 INFO - mkdir: /builds/slave/test-pgo/properties 15:51:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:51:28 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:51:28 INFO - Contents: 15:51:28 INFO - build_url:https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 15:51:29 INFO - Running post-action listener: _resource_record_post_action 15:51:29 INFO - Running post-action listener: set_extra_try_arguments 15:51:29 INFO - ##### 15:51:29 INFO - ##### Running populate-webroot step. 15:51:29 INFO - ##### 15:51:29 INFO - Running pre-action listener: _resource_record_pre_action 15:51:29 INFO - Running main action method: populate_webroot 15:51:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:51:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:51:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:51:29 INFO - '--tppagecycles', 15:51:29 INFO - '7'], 15:51:29 INFO - 'tests': ['tsvgm']}}, 15:51:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:51:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:51:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 15:51:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:51:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:51:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'tests': ['damp', 'tps']}, 15:51:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['damp', 'tps']}, 15:51:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:51:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:51:29 INFO - 'other': {'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other_l64': {'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'other_nol64': {'tests': ['a11yr', 15:51:29 INFO - 'ts_paint', 15:51:29 INFO - 'tpaint', 15:51:29 INFO - 'sessionrestore', 15:51:29 INFO - 'sessionrestore_no_auto_restore', 15:51:29 INFO - 'tabpaint']}, 15:51:29 INFO - 'svgr': {'tests': ['tsvgx', 15:51:29 INFO - 'tsvgr_opacity', 15:51:29 INFO - 'tart', 15:51:29 INFO - 'tscrollx', 15:51:29 INFO - 'cart']}, 15:51:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['tsvgx', 15:51:29 INFO - 'tsvgr_opacity', 15:51:29 INFO - 'tart', 15:51:29 INFO - 'tscrollx', 15:51:29 INFO - 'cart']}, 15:51:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'tests': ['tp5o']}, 15:51:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--e10s'], 15:51:29 INFO - 'tests': ['tp5o']}, 15:51:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--xperf_path', 15:51:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:29 INFO - 'tests': ['tp5n']}, 15:51:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:51:29 INFO - 'talos_options': ['--e10s', 15:51:29 INFO - '--xperf_path', 15:51:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:51:29 INFO - 'tests': ['tp5n']}}, 15:51:29 INFO - 'talos.zip': {'path': '', 15:51:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:51:29 INFO - Running post-action listener: _resource_record_post_action 15:51:29 INFO - ##### 15:51:29 INFO - ##### Running create-virtualenv step. 15:51:29 INFO - ##### 15:51:29 INFO - Running pre-action listener: _resource_record_pre_action 15:51:29 INFO - Running main action method: create_virtualenv 15:51:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:51:29 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:51:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:51:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:51:29 INFO - Using real prefix '/usr' 15:51:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:51:30 INFO - Installing distribute.............................................................................................................................................................................................done. 15:51:32 INFO - Installing pip.................done. 15:51:32 INFO - Return code: 0 15:51:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:51: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')]} 15:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:51: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 pip>=1.5 15:51:32 INFO - Using env: {'DISPLAY': ':0', 15:51:32 INFO - 'HOME': '/home/cltbld', 15:51:32 INFO - 'LANG': 'en_US.UTF-8', 15:51:32 INFO - 'LANGUAGE': 'en_US:en', 15:51:32 INFO - 'LOGNAME': 'cltbld', 15:51:32 INFO - 'MAIL': '/var/mail/cltbld', 15:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:32 INFO - 'MOZ_NO_REMOTE': '1', 15:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:32 INFO - 'NO_EM_RESTART': '1', 15:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:32 INFO - 'SHELL': '/bin/bash', 15:51:32 INFO - 'SHLVL': '1', 15:51:32 INFO - 'TERM': 'linux', 15:51:32 INFO - 'TMOUT': '86400', 15:51:32 INFO - 'USER': 'cltbld', 15:51:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:32 INFO - '_': '/tools/buildbot/bin/python'} 15:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:32 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:51:32 INFO - Cleaning up... 15:51:32 INFO - Return code: 0 15:51:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:51: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')]} 15:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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')]} 15:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51: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', '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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:51: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 psutil>=0.7.1 15:51:32 INFO - Using env: {'DISPLAY': ':0', 15:51:32 INFO - 'HOME': '/home/cltbld', 15:51:32 INFO - 'LANG': 'en_US.UTF-8', 15:51:32 INFO - 'LANGUAGE': 'en_US:en', 15:51:32 INFO - 'LOGNAME': 'cltbld', 15:51:32 INFO - 'MAIL': '/var/mail/cltbld', 15:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:32 INFO - 'MOZ_NO_REMOTE': '1', 15:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:32 INFO - 'NO_EM_RESTART': '1', 15:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:32 INFO - 'SHELL': '/bin/bash', 15:51:32 INFO - 'SHLVL': '1', 15:51:32 INFO - 'TERM': 'linux', 15:51:32 INFO - 'TMOUT': '86400', 15:51:32 INFO - 'USER': 'cltbld', 15:51:32 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:32 INFO - '_': '/tools/buildbot/bin/python'} 15:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:32 INFO - Downloading/unpacking psutil>=0.7.1 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51: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 15:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:51:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:34 INFO - Installing collected packages: psutil 15:51:34 INFO - Running setup.py install for psutil 15:51:34 INFO - building 'psutil._psutil_linux' extension 15:51:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:51:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:51:34 INFO - building 'psutil._psutil_posix' extension 15:51:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:51:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:51:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:51:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:51:35 INFO - Successfully installed psutil 15:51:35 INFO - Cleaning up... 15:51:35 INFO - Return code: 0 15:51:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:35 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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:51:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:51:35 INFO - Using env: {'DISPLAY': ':0', 15:51:35 INFO - 'HOME': '/home/cltbld', 15:51:35 INFO - 'LANG': 'en_US.UTF-8', 15:51:35 INFO - 'LANGUAGE': 'en_US:en', 15:51:35 INFO - 'LOGNAME': 'cltbld', 15:51:35 INFO - 'MAIL': '/var/mail/cltbld', 15:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:35 INFO - 'MOZ_NO_REMOTE': '1', 15:51:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:35 INFO - 'NO_EM_RESTART': '1', 15:51:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:35 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:35 INFO - 'SHELL': '/bin/bash', 15:51:35 INFO - 'SHLVL': '1', 15:51:35 INFO - 'TERM': 'linux', 15:51:35 INFO - 'TMOUT': '86400', 15:51:35 INFO - 'USER': 'cltbld', 15:51:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:35 INFO - '_': '/tools/buildbot/bin/python'} 15:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:37 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:51:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:51:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:51:37 INFO - Installing collected packages: mozsystemmonitor 15:51:37 INFO - Running setup.py install for mozsystemmonitor 15:51:37 INFO - Successfully installed mozsystemmonitor 15:51:37 INFO - Cleaning up... 15:51:37 INFO - Return code: 0 15:51:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:37 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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:51:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:37 INFO - Using env: {'DISPLAY': ':0', 15:51:37 INFO - 'HOME': '/home/cltbld', 15:51:37 INFO - 'LANG': 'en_US.UTF-8', 15:51:37 INFO - 'LANGUAGE': 'en_US:en', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MAIL': '/var/mail/cltbld', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SHLVL': '1', 15:51:37 INFO - 'TERM': 'linux', 15:51:37 INFO - 'TMOUT': '86400', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - '_': '/tools/buildbot/bin/python'} 15:51:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:51:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:40 INFO - Downloading docopt-0.6.1.tar.gz 15:51:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:40 INFO - Running setup.py install for blobuploader 15:51:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:40 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:51:40 INFO - Running setup.py install for requests 15:51:40 INFO - Running setup.py install for docopt 15:51:40 INFO - Successfully installed blobuploader requests docopt 15:51:40 INFO - Cleaning up... 15:51:40 INFO - Return code: 0 15:51:40 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:40 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:51:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:40 INFO - Using env: {'DISPLAY': ':0', 15:51:40 INFO - 'HOME': '/home/cltbld', 15:51:40 INFO - 'LANG': 'en_US.UTF-8', 15:51:40 INFO - 'LANGUAGE': 'en_US:en', 15:51:40 INFO - 'LOGNAME': 'cltbld', 15:51:40 INFO - 'MAIL': '/var/mail/cltbld', 15:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:40 INFO - 'MOZ_NO_REMOTE': '1', 15:51:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:40 INFO - 'NO_EM_RESTART': '1', 15:51:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:40 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:40 INFO - 'SHELL': '/bin/bash', 15:51:40 INFO - 'SHLVL': '1', 15:51:40 INFO - 'TERM': 'linux', 15:51:40 INFO - 'TMOUT': '86400', 15:51:40 INFO - 'USER': 'cltbld', 15:51:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:40 INFO - '_': '/tools/buildbot/bin/python'} 15:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:41 INFO - Running setup.py (path:/tmp/pip-ii1TvH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:41 INFO - Running setup.py (path:/tmp/pip-WaMhRU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:41 INFO - Running setup.py (path:/tmp/pip-rEctgV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:41 INFO - Running setup.py (path:/tmp/pip-ISg8ta-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:41 INFO - Running setup.py (path:/tmp/pip-XdM4EP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:41 INFO - Running setup.py (path:/tmp/pip-dSrlhM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:41 INFO - Running setup.py (path:/tmp/pip-m64kNU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:41 INFO - Running setup.py (path:/tmp/pip-K1twtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:41 INFO - Running setup.py (path:/tmp/pip-DBWzyV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:41 INFO - Running setup.py (path:/tmp/pip-IIkPTQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:41 INFO - Running setup.py (path:/tmp/pip-zvA6NR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:41 INFO - Running setup.py (path:/tmp/pip-GK0pcS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:42 INFO - Running setup.py (path:/tmp/pip-e_rQFt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:42 INFO - Running setup.py (path:/tmp/pip-_oMNYk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:42 INFO - Running setup.py (path:/tmp/pip-tPa6sg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:42 INFO - Running setup.py (path:/tmp/pip-cQRb3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:42 INFO - Running setup.py (path:/tmp/pip-takYPo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:42 INFO - Running setup.py install for manifestparser 15:51:42 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:51:42 INFO - Running setup.py install for mozcrash 15:51:42 INFO - Running setup.py install for mozdebug 15:51:42 INFO - Running setup.py install for mozdevice 15:51:42 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:51:42 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:51:42 INFO - Running setup.py install for mozfile 15:51:42 INFO - Running setup.py install for mozhttpd 15:51:43 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for mozinfo 15:51:43 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for mozInstall 15:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for mozleak 15:51:43 INFO - Running setup.py install for mozlog 15:51:43 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for moznetwork 15:51:43 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for mozprocess 15:51:43 INFO - Running setup.py install for mozprofile 15:51:43 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for mozrunner 15:51:43 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:51:43 INFO - Running setup.py install for mozscreenshot 15:51:43 INFO - Running setup.py install for moztest 15:51:44 INFO - Running setup.py install for mozversion 15:51:44 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:51:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:44 INFO - Cleaning up... 15:51:44 INFO - Return code: 0 15:51:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:51:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:44 INFO - Using env: {'DISPLAY': ':0', 15:51:44 INFO - 'HOME': '/home/cltbld', 15:51:44 INFO - 'LANG': 'en_US.UTF-8', 15:51:44 INFO - 'LANGUAGE': 'en_US:en', 15:51:44 INFO - 'LOGNAME': 'cltbld', 15:51:44 INFO - 'MAIL': '/var/mail/cltbld', 15:51:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:44 INFO - 'MOZ_NO_REMOTE': '1', 15:51:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:44 INFO - 'NO_EM_RESTART': '1', 15:51:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:44 INFO - 'SHELL': '/bin/bash', 15:51:44 INFO - 'SHLVL': '1', 15:51:44 INFO - 'TERM': 'linux', 15:51:44 INFO - 'TMOUT': '86400', 15:51:44 INFO - 'USER': 'cltbld', 15:51:44 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:44 INFO - '_': '/tools/buildbot/bin/python'} 15:51:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:44 INFO - Running setup.py (path:/tmp/pip-JSDKdy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:44 INFO - Running setup.py (path:/tmp/pip-XrYQ8Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:44 INFO - Running setup.py (path:/tmp/pip-tasoh9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:44 INFO - Running setup.py (path:/tmp/pip-go1lOG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:44 INFO - Running setup.py (path:/tmp/pip-YDg7lD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:44 INFO - Running setup.py (path:/tmp/pip-Xvitbh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:44 INFO - Running setup.py (path:/tmp/pip-T4Eo9n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:44 INFO - Running setup.py (path:/tmp/pip-OXtmu9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:51:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:51:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:44 INFO - Running setup.py (path:/tmp/pip-gBqbQo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:45 INFO - Running setup.py (path:/tmp/pip-vfYxN1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:45 INFO - Running setup.py (path:/tmp/pip-nxx1rr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:45 INFO - Running setup.py (path:/tmp/pip-W9bP0Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:45 INFO - Running setup.py (path:/tmp/pip-W4Sla3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:45 INFO - Running setup.py (path:/tmp/pip-PQc3gY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:45 INFO - Running setup.py (path:/tmp/pip-b6cId9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:45 INFO - Running setup.py (path:/tmp/pip-5YAbEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:51:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:45 INFO - Running setup.py (path:/tmp/pip-ABMeFf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:51:45 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:45 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:51:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:47 INFO - Downloading blessings-1.6.tar.gz 15:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:47 INFO - Installing collected packages: blessings 15:51:47 INFO - Running setup.py install for blessings 15:51:47 INFO - Successfully installed blessings 15:51:47 INFO - Cleaning up... 15:51:47 INFO - Return code: 0 15:51:47 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:51:47 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:51:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:51:47 INFO - Reading from file tmpfile_stdout 15:51:47 INFO - Current package versions: 15:51:47 INFO - argparse == 1.2.1 15:51:47 INFO - blessings == 1.6 15:51:47 INFO - blobuploader == 1.2.4 15:51:47 INFO - docopt == 0.6.1 15:51:47 INFO - manifestparser == 1.1 15:51:47 INFO - mozInstall == 1.12 15:51:47 INFO - mozcrash == 0.17 15:51:47 INFO - mozdebug == 0.1 15:51:47 INFO - mozdevice == 0.48 15:51:47 INFO - mozfile == 1.2 15:51:47 INFO - mozhttpd == 0.7 15:51:47 INFO - mozinfo == 0.9 15:51:47 INFO - mozleak == 0.1 15:51:47 INFO - mozlog == 3.1 15:51:47 INFO - moznetwork == 0.27 15:51:47 INFO - mozprocess == 0.22 15:51:47 INFO - mozprofile == 0.28 15:51:47 INFO - mozrunner == 6.11 15:51:47 INFO - mozscreenshot == 0.1 15:51:47 INFO - mozsystemmonitor == 0.0 15:51:47 INFO - moztest == 0.7 15:51:47 INFO - mozversion == 1.4 15:51:47 INFO - psutil == 3.1.1 15:51:47 INFO - requests == 1.2.3 15:51:47 INFO - wsgiref == 0.1.2 15:51:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:47 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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:51:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:51:47 INFO - Using env: {'DISPLAY': ':0', 15:51:47 INFO - 'HOME': '/home/cltbld', 15:51:47 INFO - 'LANG': 'en_US.UTF-8', 15:51:47 INFO - 'LANGUAGE': 'en_US:en', 15:51:47 INFO - 'LOGNAME': 'cltbld', 15:51:47 INFO - 'MAIL': '/var/mail/cltbld', 15:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:47 INFO - 'MOZ_NO_REMOTE': '1', 15:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:47 INFO - 'NO_EM_RESTART': '1', 15:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:47 INFO - 'SHELL': '/bin/bash', 15:51:47 INFO - 'SHLVL': '1', 15:51:47 INFO - 'TERM': 'linux', 15:51:47 INFO - 'TMOUT': '86400', 15:51:47 INFO - 'USER': 'cltbld', 15:51:47 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:47 INFO - '_': '/tools/buildbot/bin/python'} 15:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:51:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:51:48 INFO - Cleaning up... 15:51:48 INFO - Return code: 0 15:51:48 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:48 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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:51:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:51:48 INFO - Using env: {'DISPLAY': ':0', 15:51:48 INFO - 'HOME': '/home/cltbld', 15:51:48 INFO - 'LANG': 'en_US.UTF-8', 15:51:48 INFO - 'LANGUAGE': 'en_US:en', 15:51:48 INFO - 'LOGNAME': 'cltbld', 15:51:48 INFO - 'MAIL': '/var/mail/cltbld', 15:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:48 INFO - 'MOZ_NO_REMOTE': '1', 15:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:48 INFO - 'NO_EM_RESTART': '1', 15:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:48 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:48 INFO - 'SHELL': '/bin/bash', 15:51:48 INFO - 'SHLVL': '1', 15:51:48 INFO - 'TERM': 'linux', 15:51:48 INFO - 'TMOUT': '86400', 15:51:48 INFO - 'USER': 'cltbld', 15:51:48 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:48 INFO - '_': '/tools/buildbot/bin/python'} 15:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:48 INFO - Downloading/unpacking jsonschema 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:50 INFO - Downloading/unpacking functools32 (from jsonschema) 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:50 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:50 INFO - warning: no files found matching '*.txt' 15:51:50 INFO - no previously-included directories found matching 'build' 15:51:50 INFO - no previously-included directories found matching 'dist' 15:51:50 INFO - no previously-included directories found matching '.git*' 15:51:50 INFO - Installing collected packages: jsonschema, functools32 15:51:50 INFO - Running setup.py install for functools32 15:51:50 INFO - warning: no files found matching '*.txt' 15:51:50 INFO - no previously-included directories found matching 'build' 15:51:50 INFO - no previously-included directories found matching 'dist' 15:51:50 INFO - no previously-included directories found matching '.git*' 15:51:50 INFO - Successfully installed jsonschema functools32 15:51:50 INFO - Cleaning up... 15:51:50 INFO - Return code: 0 15:51:50 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:51:50 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 0x7f734ca6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfc38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10906d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:51:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:51:50 INFO - Using env: {'DISPLAY': ':0', 15:51:50 INFO - 'HOME': '/home/cltbld', 15:51:50 INFO - 'LANG': 'en_US.UTF-8', 15:51:50 INFO - 'LANGUAGE': 'en_US:en', 15:51:50 INFO - 'LOGNAME': 'cltbld', 15:51:50 INFO - 'MAIL': '/var/mail/cltbld', 15:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:50 INFO - 'MOZ_NO_REMOTE': '1', 15:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:50 INFO - 'NO_EM_RESTART': '1', 15:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:51:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:51:50 INFO - 'SHELL': '/bin/bash', 15:51:50 INFO - 'SHLVL': '1', 15:51:50 INFO - 'TERM': 'linux', 15:51:50 INFO - 'TMOUT': '86400', 15:51:50 INFO - 'USER': 'cltbld', 15:51:50 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:50 INFO - '_': '/tools/buildbot/bin/python'} 15:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:50 INFO - Downloading/unpacking flake8 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:51:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:51:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:51:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:53 INFO - no previously-included directories found matching 'docs/_build' 15:51:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:51:53 INFO - Running setup.py install for pep8 15:51:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:51:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:51:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:51:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:51:53 INFO - no previously-included directories found matching 'docs/_build' 15:51:53 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:51:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:51:53 INFO - Cleaning up... 15:51:53 INFO - Return code: 0 15:51:53 INFO - Running post-action listener: _resource_record_post_action 15:51:53 INFO - Running post-action listener: _start_resource_monitoring 15:51:53 INFO - Starting resource monitoring. 15:51:53 INFO - ##### 15:51:53 INFO - ##### Running install step. 15:51:53 INFO - ##### 15:51:53 INFO - Running pre-action listener: _resource_record_pre_action 15:51:53 INFO - Running main action method: install 15:51:53 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:51:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:51:54 INFO - Reading from file tmpfile_stdout 15:51:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:51:54 INFO - Reading from file tmpfile_stdout 15:51:54 INFO - Output received: 15:51:54 INFO - Usage: mozinstall [options] installer 15:51:54 INFO - Options: 15:51:54 INFO - -h, --help show this help message and exit 15:51:54 INFO - -d DEST, --destination=DEST 15:51:54 INFO - Directory to install application into. [default: 15:51:54 INFO - "/builds/slave/test-pgo"] 15:51:54 INFO - --app=APP Application being installed. [default: firefox] 15:51:54 INFO - mkdir: /builds/slave/test-pgo/build/application 15:51:54 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:51:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:52:09 INFO - Reading from file tmpfile_stdout 15:52:09 INFO - Output received: 15:52:09 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:52:09 INFO - Running post-action listener: _resource_record_post_action 15:52:09 INFO - ##### 15:52:09 INFO - ##### Running run-tests step. 15:52:09 INFO - ##### 15:52:09 INFO - Running pre-action listener: _resource_record_pre_action 15:52:09 INFO - Running main action method: run_tests 15:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:52:09 INFO - Python 2.7.3 15:52:09 INFO - Return code: 0 15:52:09 INFO - grabbing minidump binary from tooltool 15:52:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:52:09 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x111f920>, '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 0x1120820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1120cb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:52:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:52:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:52:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:52:09 INFO - Return code: 0 15:52:09 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:52:09 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:52:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:52:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:52:10 INFO - Return code: 0 15:52:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:52:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 15:52:10 INFO - Using env: {'DISPLAY': ':0', 15:52:10 INFO - 'HOME': '/home/cltbld', 15:52:10 INFO - 'LANG': 'en_US.UTF-8', 15:52:10 INFO - 'LANGUAGE': 'en_US:en', 15:52:10 INFO - 'LOGNAME': 'cltbld', 15:52:10 INFO - 'MAIL': '/var/mail/cltbld', 15:52:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:52:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:52:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:52:10 INFO - 'MOZ_NO_REMOTE': '1', 15:52:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:52:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:52:10 INFO - 'NO_EM_RESTART': '1', 15:52:10 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:52:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:52:10 INFO - 'PWD': '/builds/slave/test-pgo', 15:52:10 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:52:10 INFO - 'SHELL': '/bin/bash', 15:52:10 INFO - 'SHLVL': '1', 15:52:10 INFO - 'TERM': 'linux', 15:52:10 INFO - 'TMOUT': '86400', 15:52:10 INFO - 'USER': 'cltbld', 15:52:10 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682', 15:52:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:52:10 INFO - '_': '/tools/buildbot/bin/python'} 15:52:10 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:52:10 INFO - mozversion application_buildid: 20160406124830 15:52:10 INFO - mozversion application_changeset: 71f5a85ac2b38dbe441b2e894bea002cf9f902bd 15:52:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:52:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:52:10 INFO - mozversion application_name: Firefox 15:52:10 INFO - mozversion application_remotingname: firefox-dev 15:52:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:52:10 INFO - mozversion application_vendor: Mozilla 15:52:10 INFO - mozversion application_version: 47.0a2 15:52:10 INFO - mozversion platform_buildid: 20160406124830 15:52:10 INFO - mozversion platform_changeset: 71f5a85ac2b38dbe441b2e894bea002cf9f902bd 15:52:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:52:10 INFO - mozversion platform_version: 47.0a2 15:52:10 INFO - using testdate: 1459983130 15:52:10 INFO - actual date: 1459983130 15:52:10 INFO - starting webserver on 'localhost:55537' 15:52:10 INFO - SUITE-START | Running 2 tests 15:52:10 INFO - TEST-START | dromaeo_css 15:52:10 INFO - operating with platform_type : linux_ 15:52:10 INFO - Initialising browser for dromaeo_css test... 15:52:10 INFO - TEST-INFO | started process 20493 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmtvflf/profile http://localhost:55537/getInfo.html) 15:52:14 INFO - PROCESS | 20493 | 15:52:14 INFO - PROCESS | 20493 | (process:20569): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:52:15 INFO - PROCESS | 20493 | __metrics Screen width/height:1600/1200 15:52:15 INFO - PROCESS | 20493 | colorDepth:24 15:52:15 INFO - PROCESS | 20493 | Browser inner width/height: 1024/697 15:52:15 INFO - PROCESS | 20493 | __metrics 15:52:15 ERROR - PROCESS | 20493 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 15:52:16 INFO - TEST-INFO | 20493: exit 0 15:52:16 INFO - Browser initialized. 15:52:16 INFO - Running cycle 1/1 for dromaeo_css test... 15:52:16 INFO - TEST-INFO | started process 20620 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmtvflf/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:52:18 INFO - PROCESS | 20620 | 15:52:18 INFO - PROCESS | 20620 | (process:20689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:52:28 INFO - PROCESS | 20620 | RSS: Main: 151310336 15:52:28 INFO - PROCESS | 20620 | 15:53:18 INFO - PROCESS | 20620 | 1459983198154 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] 15:55:25 INFO - PROCESS | 20620 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55537/tests/dromaeo/cssquery-ext.html) 15:55:26 INFO - PROCESS | 20620 | RSS: Main: 154853376 15:55:26 INFO - PROCESS | 20620 | 15:58:28 INFO - PROCESS | 20620 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-ext.html (next: http://localhost:55537/tests/dromaeo/cssquery-jquery.html) 15:58:29 INFO - PROCESS | 20620 | RSS: Main: 153862144 15:58:29 INFO - PROCESS | 20620 | 16:01:31 INFO - PROCESS | 20620 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55537/tests/dromaeo/cssquery-mootools.html) 16:01:31 INFO - PROCESS | 20620 | RSS: Main: 152772608 16:01:31 INFO - PROCESS | 20620 | 16:04:33 INFO - PROCESS | 20620 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55537/tests/dromaeo/cssquery-prototype.html) 16:04:33 INFO - PROCESS | 20620 | RSS: Main: 152485888 16:04:33 INFO - PROCESS | 20620 | 16:07:36 INFO - PROCESS | 20620 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55537/tests/dromaeo/cssquery-yui.html) 16:07:36 INFO - PROCESS | 20620 | RSS: Main: 154050560 16:07:36 INFO - PROCESS | 20620 | 16:10:38 INFO - PROCESS | 20620 | Cycle 1(1): loaded http://localhost:55537/tests/dromaeo/cssquery-yui.html (next: http://localhost:55537/tests/dromaeo/cssquery-dojo.html) 16:10:39 INFO - PROCESS | 20620 | RSS: Main: 155799552 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | __start_tp_report 16:10:39 INFO - PROCESS | 20620 | _x_x_mozilla_page_load 16:10:39 INFO - PROCESS | 20620 | _x_x_mozilla_page_load_details 16:10:39 INFO - PROCESS | 20620 | |i|pagename|runs| 16:10:39 INFO - PROCESS | 20620 | |0;dojo.html;3355.496675498675;3413.14671332167;3420.076579323583;3446.948295775562;3472.374972504948;5517.475839795218;5553.8333849984565;5558.360788509318;5580.162975553669;5580.665160090392;5573.052581061229;5582.358028826686;5615.522680572156;5617.494425501704;5653.265075540174;5096.694198348102;5112.821051263207;5177.275181474596;5188.221766734982;5198.792048318062;5021.6735912165595;5110.080185566597;5116.974415127919;5208.401033881095;5217.034848553011;5127.769250383742;5181;5213.765380557884;5215.1655735082395;5222.529972302492;5148.330717006803;5173.042987047389;5173.663711858717;5188.5849132069725;5201.791928322863;5008.84973450797;5037.874053148664;5051.823186188502;5065.214891691794;5100.413452452941;5328.6802791832615;5344.732763361816;5373.462653734634;5396.082665946759;5420.620556561043;5979.671118088503;5980.372060933583;5988.431099045583;5989.970050149765;5993.041113421875;5934.465898069195;5947.910781338283;6020.397960203988;6070.908936365958;6091.42131497507;5639.68981706006;5651.576131790132;5651.604387692863;5653.462921022497;5675;6088.665123418166;6145.047517634774;6145.8156255312415;6146.108814222002;6153.84615384619;5779.219805326227;5829.650220986754;5899.085641725539;5905.055191169392;5960.523158147338;6094.268687757409;6095.573309868355;6113.32753397126;6117.541184411187;6124.938750612437;5904.911426328608;6060.545459090586;6060.606060606046;6067.575269731165;6076.483498902643;5953.22608060958;5996.820095397145;6023.216981792339;6027;6055.788047418319;4610.95389046112;4623.890266336122;4639.420072490939;4654.604358629555;4675.532446755297;4052.371882358239;4070.063885306396;4168.437260969791;4172.561881002512;4205.411242426063;5627.8874422512135;5669;5763.6541807491685;5813.331466881363;5842.532597392198;6112.17485639433;6136.140940268366;6141.263048434216;6149.169862068653;6158.1686472326555;5531.3915469298345;5665.830025099253;5715.8856822864145;5739.684317362502;5740.225069615632;5169.353830771153;5180.844574662766;5181.766820493087;5188.45521220274;5212.40057393397;6241.96879015602;6252.5935814171935;6253;6261.186045814015;6271.466925311308;5987.712641782038;6050.515958723204;6056.303525094582;6063.423974722395;6135.417135372132;6333.524985626004;6344.143540622142;6348.841278968062;6350.841228969128;6358.77744278948;6009.609375390585;6022.759089636365;6025.0661147522205;6026.758929642765;6042.546808989256;5933.228680271537;6069.362716914837;6109.694515274307;6117.644716737863;6155.169052177898;5880.529557635465;5962.672053037125;5963.016102343065;5970.223870896929;5982.072778719132;5912.763489460373;5934.406559344031;5974.372690867396;5979.671118088547;5981.3719559445635;5584.329880414376;5809.390014048464;5875.383084776208;5883.94116058834;5899.705014749159;5822.883542329045;5847.707614619167;5863.032599621015;5868.2077919480325;5894.056950887837;5668.26312579362;5692.573057020657;5698.344690360495;5700.030994730822;5703.657780533182 16:10:39 INFO - PROCESS | 20620 | |1;ext.html;495.707532555792;570.3127731084044;587.8677297608036;600.6876424259385;608.7017361492868;31274;40196.59803401965;40626.390604140885;40983.59016409835;41020;44997.7750111249;45438.318425223646;45620.315695264515;45703;45798;8900.866487002684;9057.864132037992;9058.728238152833;9069.682561110363;9083.137101975302;8789.604467798965;8922.955385223066;8942.73171804847;8960.059193784657;9239.122283383067;9246.306527010467;9255.444673319622;9259.074092590754;9274.304427167956;9300.116488933574;9204.355695101312;9213.0786921308;9240.630374785;9249.676261330855;9284.814303713956;9039.231665308456;9210.723678289594;9210.861837072449;9225.077492250788;9233.030531794198;45426.31860522095;45637.771811141065;45816.312755308696;45958.77020614909;45961;3578;3600.6039335673054;3737.1404576947452;4075.49056367954;4305.763183024932;31503;31731.365372692417;31854.522182167053;32343;32682.673173268202;4178.791060446965;4196.9370459443135;4212.978935105336;4217.704760666755;4229.809658565372;233013;234500;234662;235498;237417;47344.5265547347;70910.29089709037;72093.63953180201;72487;72604;51796;51805;52243.47756522386;52320;52338.47661523336;15915.283812228477;16176.352945882269;16178.595535111717;16190.75713864293;16220.351185952666;12811.295378754072;12881.677958051123;12996.935015324863;13021.739565208833;13088.607341779762;16147.434839780786;16353.34586616522;16433.09617970999;16474;16486.422975195812;6473.611583305017;6543.378379053982;6584.6830633873415;6604.900926486107;6664.5334826561675;1087.3584585094675;1112.2103306652207;1140.984523773842;1161.3960740415105;1174.4186627619213;30952.69047309498;31011.06966791;31122.377552449278;31389.37221255562;31453.528197077063;1156.780211759763;1163.0869767232682;1168.2231316174818;1226.4726167747954;1253.8181963615225;15834.920825395799;15922.522324330288;16049.438269660506;16467.423640172536;16693.749593756103;282875;333694;750143;754228;759993;63911.36088639147;64815.35184648093;64870;64874;65042.67478662671;1444.6749481366608;1445.0390490323816;1446.985530144685;1474.0345073976562;1501.054335768459;30778.846105769328;31984.200394990312;32397.19007024843;32679.18302042468;32723.181920452178;62388;63738.68130659317;64357.67821160864;64398;64479.35520644921;305910;311214;311429;311547;311816;48531.5146848527;49249.753751231015;49351.753241233564;49631.255531167786;50211.24683129683;51534;52661.21008184804;52664.21003684871;52753.73623132013;53883;41343.58656413398;42670.57329426666;43365.3495197566;44228.77885610551;45012.77493612642;43352.56647433485;43426.348604771585;43801.78099109484;43849.78075109604;43903;42735;43589;44073.55926440695;44291.55708443003;44423.777881110385;37156;37225.6277437233;37275.81362093172;37427;37574;29023.274418139714;29397;29499.55750663699;29552;29619.407611848073 16:10:39 INFO - PROCESS | 20620 | |2;jquery.html;355.3568041844262;357.6495034865831;364.5934782717271;382.62120500704293;383.52059925093636;17351.826481735177;18110.185041673125;19644.410667679957;19690.212391504323;19767.308144214974;18144.18351174197;18417;18602.53493662659;18612.44162675122;18671.626567468644;5269.420363759974;5561.694106824123;5572.275604171452;5573.331200255975;5601.719914004304;4138.255114079465;5461.1535212042;5727.083666613343;5951.137085122655;5987.850303742398;5865.677387743673;5906.852328691774;5913.2608423947;5913.674747888865;5945.227120474332;5664.037113690682;5931.021381472052;5942.5840191186635;5943.167956486095;5960.165576819249;5191.792328306863;5204.34945631796;5215.739213039371;5241.580673546107;5256.789728410859;21400.785992140034;21467.892660536752;22170.556588868134;22359.552808943892;22386.776132238796;2138.4653836540865;2178.575177840322;2253.076238742124;2336.941576460585;2439.195065628356;10215.642452514126;10304.845427318596;10343.534540945675;10860.6198783043;12953.28756918369;1805.0433270366727;1805.6117934643983;1893.195391958426;1940.8350290225349;1949.1521188283143;66560.66719666419;67770;68040;69012.654936725;69742;9914.40513569188;10209.591616335412;10298;10335.431551264603;10375.792484150426;14719.852801471849;14772.704545909022;14885.181315027561;14899.03156294859;14914.328855201542;7772.494787838886;7875.133735289228;7927.643256053491;7942.285194332538;8004.439689221698;7492.662830172655;7532.623368831537;7557.697692092364;7563.092428908456;7646.23537646242;4564.42917204884;4691.272852707836;4706.1999460091865;4708.340832283483;4738.881527961828;1898.1553208822218;1951.8731282466879;1959.4121763470903;1966.0857701169025;1971.7831038585743;988.9208863290919;1005.3615953869199;1009.9343542669703;1044.806710758512;1091.9727006824894;15486.22568871552;17034;17202.053887036334;17389;17701.822981770274;931.4271722890373;997.7555498902815;1014.8122597319519;1023.559869256227;1024.7079582319004;10022.448765317831;10141.2394070445;10141.543630536644;10172;10328.845067323997;479268;487198;487201;496222;499641;77194.61402693063;77583;78884.60557697175;80592.59406511327;80654.59672701599;1027.2141811514198;1041.7083216699336;1050.1179009631794;1089.0470838016736;1099.197585762398;15968.680626387175;16031.519054428385;16111.436099736453;16268.349266029227;16332.101734404721;25638.743612563634;35139.64860351364;36052.8197359022;36551.634483655886;36971.07572310714;51174;52208;53010.73494632502;53024;53069.73465132649;8021.27808497238;8142.8778568322705;8151.633176506953;8199.385046121446;8358.623861926106;9574.712758617252;11225.214235003472;12377.195482293622;12517.687057823627;12530.498780048696;9945.204383649147;10051.396916185053;10201.54093065799;10402.427866467417;10671.94664026675;10434.895651043393;10659.200559957879;10701.678949631523;10744.409057501913;10827;10264.948675256575;10271.6103685785;10662.520186591466;10780.093679154117;10901.236913415985;8154.429189956646;8264.710735124241;8320.958395207985;8326.62530186131;8394.076651568445;9657.32398732082;9953.452560109263;10470.947645261725;10493.580256789948;10870.293430926964 16:10:39 INFO - PROCESS | 20620 | |3;mootools.html;1607.5177446765967;1630.4537979776771;1882.2753240002603;1973.901304934753;2007.558337165824;7763.223677632234;8424.789380265496;8455.281301089408;8676.262517686004;8690.608922598474;8387.454815437008;8401.327893768499;8486.321094312456;8496.575171241444;8508.787280317994;2411.1922505960524;2435.2815919303757;2440.9145679901208;2440.987795061022;2444.8655323957173;2308.503671710582;2340.4382948092507;2346.753590872959;2348;2348.906043758256;2408.217329367954;2433.0146290752273;2450.3629056445275;2450.5098980203943;2457.7910877575428;2392.3301475586863;2401.387646150238;2414.5291668124723;2416.8429052111555;2456.852588844675;2377.358113309414;2391.0794344177443;2395.401149712572;2401.5557121932497;2421.1041914491575;8661.956690216508;8683.522406267653;8690.869636955451;8691.739247822576;8724.34567407447;5193.870153246161;5270.051390749663;5320.334958130234;5347.572194224492;5363;3038.7417069549115;3059.521787352252;3096.9315586122975;3161.8577164027674;3209.3420848725955;881.5988725130051;890.7951171230588;894.1014280647908;908.0238743350858;917.9357444978854;12219.816702749466;12279.447424865992;12312.322822244772;12354;12355.938220308932;4591.678582499193;4617.815287388534;4638.95361046392;4664.86005419838;4745.074710431432;10380;10405.635802746867;10411.947940260401;10417.166626669848;10440.269181157246;5384.219288203189;5407.080796264644;5412.700951771625;5415.83752487426;5452.890942181134;4206.348016057516;4638.1883170445035;4677.18149323867;4699.177643912301;4886.584640305614;3847.442120892455;3857.228554289153;3891.2606604745006;3904.550976637723;3920.2159568086495;1228.2384921348641;1242.2298175131477;1242.3043095866344;1247.8876901078947;1262.9052821038458;1212.1575505023923;1220.2251570252777;1230.7476967221698;1504.8645621894082;1522.3453914816514;7749.573773442402;7844.725434609875;7917.920820791834;7958.08482024563;8369.707060252862;1219.908506861971;1222.2727477151082;1226.8405107336168;1243.6952946528158;1264.8608653048157;6463.450606698483;6479.319671434431;6503.2521260054755;6506.512011599149;6573.769918052845;10269.94865025685;10607.734806629896;10617.522211500347;10627.521761520595;10693.144548436261;10264.897351026544;10381.636642717469;10487.528061237263;10512.474376281156;10513.684589462327;8248.422610417214;8263.173682631808;8292.958535207406;8384.161583841567;8401.663933442716;7893.447458678067;7991;8020.0375954885785;8081.353491720531;8087.919120808717;9000.459972401677;9101.908980910372;9123.361364704408;9147.176754092163;9194.26445884341;9297.67458138962;9412.905870941204;9576.952115239379;9593;9790.804183916423;6714.127163468718;7392.778216653509;7571.545707257582;7574.697012119674;7604;8263.297619702393;8280.337572994267;8295.958520207601;8306.501609903184;8315.293200078062;7042.330978557029;7173.892391614026;7269.055022846996;7337.74317898871;7367.042284502981;6924.376806087476;6928.16861976566;6988.615626140611;7073.504854660125;7145.249748776304;7690.846183076419;7837.216278372117;7870.645820938186;7870.72452464161;7871.448998570274;7132.500724949204;7155.713771449292;7234.5659260444545;7240.05879235717;7243.782686519413;7163.677634506564;7258.818529536804;7266.6729997151315;7267.890981635385;7275.017872587345 16:10:39 INFO - PROCESS | 20620 | |4;prototype.html;329.89443378118995;330.7023678689181;330.7982130900152;338.83735806812723;344.74316634107583;6361.650109244001;6374.776882809103;6402.935970640292;6448.61308321501;6450.870982580352;6260.092286618437;6262.906056409146;6305.590136641115;6305.905411418832;6339.36606339367;4531.161735079021;4719.9292010619865;4800.135975524396;4833.492483289257;4847.224444088946;4840.370751802261;4848.369711937461;4859.271109333593;4862.927056094161;4871.5615594596475;4795.832145874895;4809.206480930642;4814.87962800931;4821.4696383397795;4832.73419961902;4785.569298763093;4820.156472617296;4826.927596086061;4843.733594652293;4847.3213750074665;4239.173361194568;4242.851500197478;4249.617534421886;4256.553061928484;4258.488981322261;5805.216295800055;6003.6397816131175;6008.969955150196;6014.188084608566;6017.127516510125;5505.862353441156;5528.281323427969;5536.363318218416;5539.058360078796;5540.141278101901;6623.238327592292;6680.699368528428;6683.030960510699;6688.063671086052;6697.22981857083;4530.071335376273;4559.042601053749;4564.2240819060835;4564.292534657134;4568.291914753218;6897.862042759167;6966.02475653414;6975.267596902354;6980.581165130108;6989.5456795308655;4523.36672865799;4550.34020067095;4585.885352866205;4587.082583483317;4698.906021879543;4711.7879695413785;4718.575328220477;4752;4753.786079626425;4775.331453596499;5474.452554744574;5497.422770609109;5504.504594586427;5518.668879867221;5519.116941289374;6676.399124078759;6689.163854518185;6704.195496540349;6711.932880671228;6729.831754206086;1664.2926756128838;1687.8902871313326;1692.6445446456137;1693.2803558487594;1698.6178109925168;1037.1443559063803;1067.124957534814;1070.769784496337;1073.3774410841693;1088.0588291128117;6442.098106265126;6460.58006229603;6482.222133344029;6503.447206987365;6516.934830651633;6868.896966545506;6874.828129296808;6893.310668933066;6899.93100069003;6911.274316196827;6427.453666438405;6526.086347911296;6544.672766361663;6549.050387693853;6603.834904127435;3758.680512156497;3783.7729736215915;3796.2787070457075;3800.9809950950066;3815.198808250243;7312.561246325237;7353.117625884928;7358.742444014434;7360.33756961876;7370.078740157481;7137.89293160603;7147.428205743528;7159.821004474826;7177.820554486075;7208.4954053216825;6997.510174287751;7286.927130728731;7303.087114110736;7342.743003994835;7375.336219740142;6960.408365288805;6977.7208911642965;6978.581285122909;6992.1958974718555;6992.895106573304;6870.27862074495;6870.484713646597;6872.656367181721;6876.621785801829;6887.483438742014;7242.782716518513;7290.453216008927;7319.268073192638;7328.560286382834;7382.114146302478;4641.535846415331;4723.574878260973;4731.29030645406;4739.810407583658;4749.786259618395;7018.122734658168;7027.789166325018;7029.156501219886;7030.683619237045;7031.683574239274;6828.385445309946;6843.247242803188;6855.760048398282;6868.656567171522;6886.139232595926;6808.93191068083;6809.182898052265;6819.863602728017;6831.6242606657115;6868.278830722702;6586.868262634624;6619.709156714394;6665.100211471389;6691.76578819739;6710.6309152997055;6778.525503214925;6782.762603308861;6783.626900520321;6804.11546498952;6827.658617069226;6562;6578.309277525982;6582.078509008838;6629;6649.567778094602 16:10:39 INFO - PROCESS | 20620 | |5;yui.html;773.7949443397497;775.9961200194;776.0493395590399;825.8348330333931;884.2704768565933;12135.575254866082;14740.33668484918;14973.401063957455;15103.773443398359;15117.092974421528;13288.867111328884;13303.068785185042;13410.530631427902;13463.326833658302;13507.72984540311;914.1955079530037;931.9767005824875;941.2658126661181;962.1004360922525;964.5996911281844;958.2190514730472;960.5149399553216;960.524540352523;962.0716009051264;964.7732782796037;980.9950950245238;993.9701808945707;996.8155891160122;997.2670087485692;997.4264797741328;984.7045886234173;985.074030411411;985.1035557642547;990.1534188268998;991.3011327014437;731.8572878288736;734.4638413957788;734.6436978065634;735.2500449541491;735.9411247100219;13647.249401282925;13740.10689305202;13833.170009799444;13833.239171845646;13868.237246951414;12579.496820127184;12580.68548286291;12592.685182870502;12736.490540378374;12907;10543.156547476183;10576.365418074864;10730.087942524895;10760.515776790064;10773.245872788908;3661.359262129117;3768.8492460301554;3770.0951771574623;3789.5452545694416;3806.2958352704836;52385.73807130978;52680;53277.200841987404;53294;53798;9766.36518626287;9791.314607977516;10059.094681478702;10112.696619101438;10276.126529245097;16792;16830.074345911093;16862.494125176265;16913.408030718867;16985.830141698672;7205.099362579677;7255.274472552703;7338.192798792129;7378.778636640909;7464.178940316561;4150.27370210212;4220.810063547147;4240.787960601958;4267.445232119804;4326.935095973563;3172.968270317267;3199.216192032967;3203.1351535085396;3204.5193221017034;3205.7916235444623;573.3521121133093;582.051256451989;583.3670467542679;583.6118980877669;585.3297973819953;563.706872426336;585.3356440440131;621.273110460762;636.726207730671;644.1883227133845;7946.324562412144;8358.582070896431;8486.618102185417;8493.108223636553;8537.701180458655;593.7150167919336;693.7537174303151;713.0765658472291;713.4328209073799;719.7444907058024;3818.4585443748374;3821.331267028259;3872.0707030312524;3876.5154355705536;3920.627540383659;58204.41795582075;58258.4174158253;59067;59071.40928590745;59136;52252.21621675678;52715.47284527183;53342.199867002026;53519.464805352225;54326.728366357915;48261.5173848257;51934;53275.467245327054;54347;54832.72583637056;8502.659893604186;8545.914540854512;8579.227869491775;8583.527905965231;8742.344324175585;35589.64410355863;35664.643353566134;35902.461463078595;36581.817090914374;37570.624293756715;41654.79172604118;45997;46603.53396465992;46637.06725865532;46792.08683088227;10066.949665251626;10080.596776128872;10277.537510811882;10361.948190259302;10546.525406356886;10919.945400272947;10935.234533582572;10987.725306867393;10993;11038.668839934815;10509.894901050891;10569.841452378374;10573.04842564173;10578.947105264733;10669.839952400565;10653.467326633483;10834.187435942178;10871.184661150288;10970.945145274223;11017.944910275397;10367.170626350025;10368.844467333147;10397.272190946562;10508.894911050791;10731.946340268249;9207.58565864551;9278.536073196177;9350.859737103812;9409.811803764023;9418.340716149803;9132.223760980125;9757.707268781947;9782.951085244527;9783.168430683472;9790.007818063292 16:10:39 INFO - PROCESS | 20620 | __end_tp_report 16:10:39 INFO - PROCESS | 20620 | __start_cc_report 16:10:39 INFO - PROCESS | 20620 | _x_x_mozilla_cycle_collect,333 16:10:39 INFO - PROCESS | 20620 | __end_cc_report 16:10:39 INFO - PROCESS | 20620 | __startTimestamp1459984239012__endTimestamp 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | ------- Summary: start ------- 16:10:39 INFO - PROCESS | 20620 | Number of tests: 6 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | [#0] dojo.html Cycles:165 Average:5607.52 Median:5822.88 stddev:623.85 (10.7%) stddev-sans-first:600.23 16:10:39 INFO - PROCESS | 20620 | Values: 3355.5 3413.1 3420.1 3446.9 3472.4 5517.5 5553.8 5558.4 5580.2 5580.7 5573.1 5582.4 5615.5 5617.5 5653.3 5096.7 5112.8 5177.3 5188.2 5198.8 5021.7 5110.1 5117.0 5208.4 5217.0 5127.8 5181.0 5213.8 5215.2 5222.5 5148.3 5173.0 5173.7 5188.6 5201.8 5008.8 5037.9 5051.8 5065.2 5100.4 5328.7 5344.7 5373.5 5396.1 5420.6 5979.7 5980.4 5988.4 5990.0 5993.0 5934.5 5947.9 6020.4 6070.9 6091.4 5639.7 5651.6 5651.6 5653.5 5675.0 6088.7 6145.0 6145.8 6146.1 6153.8 5779.2 5829.7 5899.1 5905.1 5960.5 6094.3 6095.6 6113.3 6117.5 6124.9 5904.9 6060.5 6060.6 6067.6 6076.5 5953.2 5996.8 6023.2 6027.0 6055.8 4611.0 4623.9 4639.4 4654.6 4675.5 4052.4 4070.1 4168.4 4172.6 4205.4 5627.9 5669.0 5763.7 5813.3 5842.5 6112.2 6136.1 6141.3 6149.2 6158.2 5531.4 5665.8 5715.9 5739.7 5740.2 5169.4 5180.8 5181.8 5188.5 5212.4 6242.0 6252.6 6253.0 6261.2 6271.5 5987.7 6050.5 6056.3 6063.4 6135.4 6333.5 6344.1 6348.8 6350.8 6358.8 6009.6 6022.8 6025.1 6026.8 6042.5 5933.2 6069.4 6109.7 6117.6 6155.2 5880.5 5962.7 5963.0 5970.2 5982.1 5912.8 5934.4 5974.4 5979.7 5981.4 5584.3 5809.4 5875.4 5883.9 5899.7 5822.9 5847.7 5863.0 5868.2 5894.1 5668.3 5692.6 5698.3 5700.0 5703.7 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | [#1] ext.html Cycles:180 Average:56133.05 Median:43358.96 stddev:113007.36 (260.6%) stddev-sans-first:113247.17 16:10:39 INFO - PROCESS | 20620 | Values: 495.7 570.3 587.9 600.7 608.7 31274.0 40196.6 40626.4 40983.6 41020.0 44997.8 45438.3 45620.3 45703.0 45798.0 8900.9 9057.9 9058.7 9069.7 9083.1 8789.6 8923.0 8942.7 8960.1 9239.1 9246.3 9255.4 9259.1 9274.3 9300.1 9204.4 9213.1 9240.6 9249.7 9284.8 9039.2 9210.7 9210.9 9225.1 9233.0 45426.3 45637.8 45816.3 45958.8 45961.0 3578.0 3600.6 3737.1 4075.5 4305.8 31503.0 31731.4 31854.5 32343.0 32682.7 4178.8 4196.9 4213.0 4217.7 4229.8 233013.0 234500.0 234662.0 235498.0 237417.0 47344.5 70910.3 72093.6 72487.0 72604.0 51796.0 51805.0 52243.5 52320.0 52338.5 15915.3 16176.4 16178.6 16190.8 16220.4 12811.3 12881.7 12996.9 13021.7 13088.6 16147.4 16353.3 16433.1 16474.0 16486.4 6473.6 6543.4 6584.7 6604.9 6664.5 1087.4 1112.2 1141.0 1161.4 1174.4 30952.7 31011.1 31122.4 31389.4 31453.5 1156.8 1163.1 1168.2 1226.5 1253.8 15834.9 15922.5 16049.4 16467.4 16693.7 282875.0 333694.0 750143.0 754228.0 759993.0 63911.4 64815.4 64870.0 64874.0 65042.7 1444.7 1445.0 1447.0 1474.0 1501.1 30778.8 31984.2 32397.2 32679.2 32723.2 62388.0 63738.7 64357.7 64398.0 64479.4 305910.0 311214.0 311429.0 311547.0 311816.0 48531.5 49249.8 49351.8 49631.3 50211.2 51534.0 52661.2 52664.2 52753.7 53883.0 41343.6 42670.6 43365.3 44228.8 45012.8 43352.6 43426.3 43801.8 43849.8 43903.0 42735.0 43589.0 44073.6 44291.6 44423.8 37156.0 37225.6 37275.8 37427.0 37574.0 29023.3 29397.0 29499.6 29552.0 29619.4 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | [#2] jquery.html Cycles:180 Average:27497.20 Median:2388.07 stddev:80323.63 (3363.5%) stddev-sans-first:80523.11 16:10:39 INFO - PROCESS | 20620 | Values: 355.4 357.6 364.6 382.6 383.5 17351.8 18110.2 19644.4 19690.2 19767.3 18144.2 18417.0 18602.5 18612.4 18671.6 5269.4 5561.7 5572.3 5573.3 5601.7 4138.3 5461.2 5727.1 5951.1 5987.9 5865.7 5906.9 5913.3 5913.7 5945.2 5664.0 5931.0 5942.6 5943.2 5960.2 5191.8 5204.3 5215.7 5241.6 5256.8 21400.8 21467.9 22170.6 22359.6 22386.8 2138.5 2178.6 2253.1 2336.9 2439.2 10215.6 10304.8 10343.5 10860.6 12953.3 1805.0 1805.6 1893.2 1940.8 1949.2 66560.7 67770.0 68040.0 69012.7 69742.0 9914.4 10209.6 10298.0 10335.4 10375.8 14719.9 14772.7 14885.2 14899.0 14914.3 7772.5 7875.1 7927.6 7942.3 8004.4 7492.7 7532.6 7557.7 7563.1 7646.2 4564.4 4691.3 4706.2 4708.3 4738.9 1898.2 1951.9 1959.4 1966.1 1971.8 988.9 1005.4 1009.9 1044.8 1092.0 15486.2 17034.0 17202.1 17389.0 17701.8 931.4 997.8 1014.8 1023.6 1024.7 10022.4 10141.2 10141.5 10172.0 10328.8 479268.0 487198.0 487201.0 496222.0 499641.0 77194.6 77583.0 78884.6 80592.6 80654.6 1027.2 1041.7 1050.1 1089.0 1099.2 15968.7 16031.5 16111.4 16268.3 16332.1 25638.7 35139.6 36052.8 36551.6 36971.1 51174.0 52208.0 53010.7 53024.0 53069.7 8021.3 8142.9 8151.6 8199.4 8358.6 9574.7 11225.2 12377.2 12517.7 12530.5 9945.2 10051.4 10201.5 10402.4 10671.9 10434.9 10659.2 10701.7 10744.4 10827.0 10264.9 10271.6 10662.5 10780.1 10901.2 8154.4 8264.7 8321.0 8326.6 8394.1 9657.3 9953.5 10470.9 10493.6 10870.3 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | [#3] mootools.html Cycles:180 Average:6012.52 Median:5395.65 stddev:3186.45 (59.1%) stddev-sans-first:3178.19 16:10:39 INFO - PROCESS | 20620 | Values: 1607.5 1630.5 1882.3 1973.9 2007.6 7763.2 8424.8 8455.3 8676.3 8690.6 8387.5 8401.3 8486.3 8496.6 8508.8 2411.2 2435.3 2440.9 2441.0 2444.9 2308.5 2340.4 2346.8 2348.0 2348.9 2408.2 2433.0 2450.4 2450.5 2457.8 2392.3 2401.4 2414.5 2416.8 2456.9 2377.4 2391.1 2395.4 2401.6 2421.1 8662.0 8683.5 8690.9 8691.7 8724.3 5193.9 5270.1 5320.3 5347.6 5363.0 3038.7 3059.5 3096.9 3161.9 3209.3 881.6 890.8 894.1 908.0 917.9 12219.8 12279.4 12312.3 12354.0 12355.9 4591.7 4617.8 4639.0 4664.9 4745.1 10380.0 10405.6 10411.9 10417.2 10440.3 5384.2 5407.1 5412.7 5415.8 5452.9 4206.3 4638.2 4677.2 4699.2 4886.6 3847.4 3857.2 3891.3 3904.6 3920.2 1228.2 1242.2 1242.3 1247.9 1262.9 1212.2 1220.2 1230.7 1504.9 1522.3 7749.6 7844.7 7917.9 7958.1 8369.7 1219.9 1222.3 1226.8 1243.7 1264.9 6463.5 6479.3 6503.3 6506.5 6573.8 10269.9 10607.7 10617.5 10627.5 10693.1 10264.9 10381.6 10487.5 10512.5 10513.7 8248.4 8263.2 8293.0 8384.2 8401.7 7893.4 7991.0 8020.0 8081.4 8087.9 9000.5 9101.9 9123.4 9147.2 9194.3 9297.7 9412.9 9577.0 9593.0 9790.8 6714.1 7392.8 7571.5 7574.7 7604.0 8263.3 8280.3 8296.0 8306.5 8315.3 7042.3 7173.9 7269.1 7337.7 7367.0 6924.4 6928.2 6988.6 7073.5 7145.2 7690.8 7837.2 7870.6 7870.7 7871.4 7132.5 7155.7 7234.6 7240.1 7243.8 7163.7 7258.8 7266.7 7267.9 7275.0 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | [#4] prototype.html Cycles:180 Average:5628.66 Median:6449.74 stddev:1729.25 (26.8%) stddev-sans-first:1687.74 16:10:39 INFO - PROCESS | 20620 | Values: 329.9 330.7 330.8 338.8 344.7 6361.7 6374.8 6402.9 6448.6 6450.9 6260.1 6262.9 6305.6 6305.9 6339.4 4531.2 4719.9 4800.1 4833.5 4847.2 4840.4 4848.4 4859.3 4862.9 4871.6 4795.8 4809.2 4814.9 4821.5 4832.7 4785.6 4820.2 4826.9 4843.7 4847.3 4239.2 4242.9 4249.6 4256.6 4258.5 5805.2 6003.6 6009.0 6014.2 6017.1 5505.9 5528.3 5536.4 5539.1 5540.1 6623.2 6680.7 6683.0 6688.1 6697.2 4530.1 4559.0 4564.2 4564.3 4568.3 6897.9 6966.0 6975.3 6980.6 6989.5 4523.4 4550.3 4585.9 4587.1 4698.9 4711.8 4718.6 4752.0 4753.8 4775.3 5474.5 5497.4 5504.5 5518.7 5519.1 6676.4 6689.2 6704.2 6711.9 6729.8 1664.3 1687.9 1692.6 1693.3 1698.6 1037.1 1067.1 1070.8 1073.4 1088.1 6442.1 6460.6 6482.2 6503.4 6516.9 6868.9 6874.8 6893.3 6899.9 6911.3 6427.5 6526.1 6544.7 6549.1 6603.8 3758.7 3783.8 3796.3 3801.0 3815.2 7312.6 7353.1 7358.7 7360.3 7370.1 7137.9 7147.4 7159.8 7177.8 7208.5 6997.5 7286.9 7303.1 7342.7 7375.3 6960.4 6977.7 6978.6 6992.2 6992.9 6870.3 6870.5 6872.7 6876.6 6887.5 7242.8 7290.5 7319.3 7328.6 7382.1 4641.5 4723.6 4731.3 4739.8 4749.8 7018.1 7027.8 7029.2 7030.7 7031.7 6828.4 6843.2 6855.8 6868.7 6886.1 6808.9 6809.2 6819.9 6831.6 6868.3 6586.9 6619.7 6665.1 6691.8 6710.6 6778.5 6782.8 6783.6 6804.1 6827.7 6562.0 6578.3 6582.1 6629.0 6649.6 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - PROCESS | 20620 | [#5] yui.html Cycles:180 Average:14167.16 Median:52318.98 stddev:16946.79 (32.4%) stddev-sans-first:16964.48 16:10:39 INFO - PROCESS | 20620 | Values: 773.8 776.0 776.0 825.8 884.3 12135.6 14740.3 14973.4 15103.8 15117.1 13288.9 13303.1 13410.5 13463.3 13507.7 914.2 932.0 941.3 962.1 964.6 958.2 960.5 960.5 962.1 964.8 981.0 994.0 996.8 997.3 997.4 984.7 985.1 985.1 990.2 991.3 731.9 734.5 734.6 735.3 735.9 13647.2 13740.1 13833.2 13833.2 13868.2 12579.5 12580.7 12592.7 12736.5 12907.0 10543.2 10576.4 10730.1 10760.5 10773.2 3661.4 3768.8 3770.1 3789.5 3806.3 52385.7 52680.0 53277.2 53294.0 53798.0 9766.4 9791.3 10059.1 10112.7 10276.1 16792.0 16830.1 16862.5 16913.4 16985.8 7205.1 7255.3 7338.2 7378.8 7464.2 4150.3 4220.8 4240.8 4267.4 4326.9 3173.0 3199.2 3203.1 3204.5 3205.8 573.4 582.1 583.4 583.6 585.3 563.7 585.3 621.3 636.7 644.2 7946.3 8358.6 8486.6 8493.1 8537.7 593.7 693.8 713.1 713.4 719.7 3818.5 3821.3 3872.1 3876.5 3920.6 58204.4 58258.4 59067.0 59071.4 59136.0 52252.2 52715.5 53342.2 53519.5 54326.7 48261.5 51934.0 53275.5 54347.0 54832.7 8502.7 8545.9 8579.2 8583.5 8742.3 35589.6 35664.6 35902.5 36581.8 37570.6 41654.8 45997.0 46603.5 46637.1 46792.1 10066.9 10080.6 10277.5 10361.9 10546.5 10919.9 10935.2 10987.7 10993.0 11038.7 10509.9 10569.8 10573.0 10578.9 10669.8 10653.5 10834.2 10871.2 10970.9 11017.9 10367.2 10368.8 10397.3 10508.9 10731.9 9207.6 9278.5 9350.9 9409.8 9418.3 9132.2 9757.7 9783.0 9783.2 9790.0 16:10:39 INFO - PROCESS | 20620 | -------- Summary: end -------- 16:10:39 INFO - PROCESS | 20620 | 16:10:39 INFO - TEST-INFO | 20620: exit 0 16:10:39 INFO - TEST-OK | dromaeo_css | took 1109090ms 16:10:39 INFO - TEST-START | kraken 16:10:39 INFO - operating with platform_type : linux_ 16:10:39 INFO - Initialising browser for kraken test... 16:10:39 INFO - TEST-INFO | started process 20868 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5355mw/profile http://localhost:55537/getInfo.html) 16:10:43 INFO - PROCESS | 20868 | 16:10:43 INFO - PROCESS | 20868 | (process:20945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:10:44 INFO - PROCESS | 20868 | __metrics Screen width/height:1600/1200 16:10:44 INFO - PROCESS | 20868 | colorDepth:24 16:10:44 INFO - PROCESS | 20868 | Browser inner width/height: 1024/697 16:10:44 INFO - PROCESS | 20868 | __metrics 16:10:44 ERROR - PROCESS | 20868 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 16:10:45 INFO - TEST-INFO | 20868: exit 0 16:10:45 INFO - Browser initialized. 16:10:45 INFO - Running cycle 1/1 for kraken test... 16:10:45 INFO - TEST-INFO | started process 20996 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5355mw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:47 INFO - PROCESS | 20996 | 16:10:47 INFO - PROCESS | 20996 | (process:21063): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 16:10:57 INFO - PROCESS | 20996 | RSS: Main: 151273472 16:10:57 INFO - PROCESS | 20996 | 16:11:00 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-beat-detection) 16:11:00 INFO - PROCESS | 20996 | RSS: Main: 155480064 16:11:00 INFO - PROCESS | 20996 | 16:11:03 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-dft) 16:11:04 INFO - PROCESS | 20996 | RSS: Main: 155377664 16:11:04 INFO - PROCESS | 20996 | 16:11:07 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-fft) 16:11:07 INFO - PROCESS | 20996 | RSS: Main: 155652096 16:11:07 INFO - PROCESS | 20996 | 16:11:09 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55537/tests/kraken/driver.html?testName=audio-oscillator) 16:11:10 INFO - PROCESS | 20996 | RSS: Main: 155729920 16:11:10 INFO - PROCESS | 20996 | 16:11:12 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:11:13 INFO - PROCESS | 20996 | RSS: Main: 155553792 16:11:13 INFO - PROCESS | 20996 | 16:11:16 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-darkroom) 16:11:16 INFO - PROCESS | 20996 | RSS: Main: 155897856 16:11:16 INFO - PROCESS | 20996 | 16:11:20 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55537/tests/kraken/driver.html?testName=imaging-desaturate) 16:11:20 INFO - PROCESS | 20996 | RSS: Main: 156278784 16:11:20 INFO - PROCESS | 20996 | 16:11:23 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55537/tests/kraken/driver.html?testName=json-parse-financial) 16:11:24 INFO - PROCESS | 20996 | RSS: Main: 156094464 16:11:24 INFO - PROCESS | 20996 | 16:11:25 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:11:26 INFO - PROCESS | 20996 | RSS: Main: 155918336 16:11:26 INFO - PROCESS | 20996 | 16:11:28 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:11:28 INFO - PROCESS | 20996 | RSS: Main: 155750400 16:11:28 INFO - PROCESS | 20996 | 16:11:30 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:11:31 INFO - PROCESS | 20996 | RSS: Main: 156274688 16:11:31 INFO - PROCESS | 20996 | 16:11:33 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:11:34 INFO - PROCESS | 20996 | RSS: Main: 156712960 16:11:34 INFO - PROCESS | 20996 | 16:11:36 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:11:37 INFO - PROCESS | 20996 | RSS: Main: 156721152 16:11:37 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | Cycle 1(1): loaded http://localhost:55537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55537/tests/kraken/driver.html?testName=ai-astar) 16:11:39 INFO - PROCESS | 20996 | RSS: Main: 158216192 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | __start_tp_report 16:11:39 INFO - PROCESS | 20996 | _x_x_mozilla_page_load 16:11:39 INFO - PROCESS | 20996 | _x_x_mozilla_page_load_details 16:11:39 INFO - PROCESS | 20996 | |i|pagename|runs| 16:11:39 INFO - PROCESS | 20996 | |0;ai-astar;114;105;114;110;111;135;114;109;111;111 16:11:39 INFO - PROCESS | 20996 | |1;audio-beat-detection;159;127;151;174;137;154;167;129;172;126 16:11:39 INFO - PROCESS | 20996 | |2;audio-dft;163;161;162;163;164;163;161;162;164;162 16:11:39 INFO - PROCESS | 20996 | |3;audio-fft;76;75;76;171;77;77;74;77;170;75 16:11:39 INFO - PROCESS | 20996 | |4;audio-oscillator;93;93;149;94;94;93;146;93;94;137 16:11:39 INFO - PROCESS | 20996 | |5;imaging-gaussian-blur;118;117;117;118;118;117;117;118;119;117 16:11:39 INFO - PROCESS | 20996 | |6;imaging-darkroom;146;150;147;147;147;148;147;148;148;148 16:11:39 INFO - PROCESS | 20996 | |7;imaging-desaturate;96;97;97;96;96;97;96;96;97;96 16:11:39 INFO - PROCESS | 20996 | |8;json-parse-financial;54;56;56;59;55;58;57;65;58;60 16:11:39 INFO - PROCESS | 20996 | |9;json-stringify-tinderbox;63;64;65;64;66;64;65;66;65;65 16:11:39 INFO - PROCESS | 20996 | |10;stanford-crypto-aes;80;81;93;79;80;89;82;80;81;79 16:11:39 INFO - PROCESS | 20996 | |11;stanford-crypto-ccm;111;113;116;121;115;120;118;113;120;114 16:11:39 INFO - PROCESS | 20996 | |12;stanford-crypto-pbkdf2;139;147;147;144;157;145;147;145;146;142 16:11:39 INFO - PROCESS | 20996 | |13;stanford-crypto-sha256-iterative;68;68;69;74;68;66;70;66;69;69 16:11:39 INFO - PROCESS | 20996 | __end_tp_report 16:11:39 INFO - PROCESS | 20996 | __start_cc_report 16:11:39 INFO - PROCESS | 20996 | _x_x_mozilla_cycle_collect,839 16:11:39 INFO - PROCESS | 20996 | __end_cc_report 16:11:39 INFO - PROCESS | 20996 | __startTimestamp1459984299438__endTimestamp 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | ------- Summary: start ------- 16:11:39 INFO - PROCESS | 20996 | Number of tests: 14 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#0] ai-astar Cycles:10 Average:113.40 Median:112.50 stddev:8.07 (7.2%) stddev-sans-first:8.56 16:11:39 INFO - PROCESS | 20996 | Values: 114.0 105.0 114.0 110.0 111.0 135.0 114.0 109.0 111.0 111.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.50 stddev:18.74 (12.0%) stddev-sans-first:19.56 16:11:39 INFO - PROCESS | 20996 | Values: 159.0 127.0 151.0 174.0 137.0 154.0 167.0 129.0 172.0 126.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 16:11:39 INFO - PROCESS | 20996 | Values: 163.0 161.0 162.0 163.0 164.0 163.0 161.0 162.0 164.0 162.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#3] audio-fft Cycles:10 Average:94.80 Median:76.00 stddev:39.91 (52.5%) stddev-sans-first:41.75 16:11:39 INFO - PROCESS | 20996 | Values: 76.0 75.0 76.0 171.0 77.0 77.0 74.0 77.0 170.0 75.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:93.00 stddev:24.61 (26.5%) stddev-sans-first:25.45 16:11:39 INFO - PROCESS | 20996 | Values: 93.0 93.0 149.0 94.0 94.0 93.0 146.0 93.0 94.0 137.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 16:11:39 INFO - PROCESS | 20996 | Values: 118.0 117.0 117.0 118.0 118.0 117.0 117.0 118.0 119.0 117.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 16:11:39 INFO - PROCESS | 20996 | Values: 146.0 150.0 147.0 147.0 147.0 148.0 147.0 148.0 148.0 148.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:11:39 INFO - PROCESS | 20996 | Values: 96.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:3.12 (5.4%) stddev-sans-first:2.99 16:11:39 INFO - PROCESS | 20996 | Values: 54.0 56.0 56.0 59.0 55.0 58.0 57.0 65.0 58.0 60.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.78 16:11:39 INFO - PROCESS | 20996 | Values: 63.0 64.0 65.0 64.0 66.0 64.0 65.0 66.0 65.0 65.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:4.72 (5.8%) stddev-sans-first:4.92 16:11:39 INFO - PROCESS | 20996 | Values: 80.0 81.0 93.0 79.0 80.0 89.0 82.0 80.0 81.0 79.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:117.00 stddev:3.48 (3.0%) stddev-sans-first:3.16 16:11:39 INFO - PROCESS | 20996 | Values: 111.0 113.0 116.0 121.0 115.0 120.0 118.0 113.0 120.0 114.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:146.50 stddev:4.65 (3.2%) stddev-sans-first:4.21 16:11:39 INFO - PROCESS | 20996 | Values: 139.0 147.0 147.0 144.0 157.0 145.0 147.0 145.0 146.0 142.0 16:11:39 INFO - PROCESS | 20996 | 16:11:39 INFO - PROCESS | 20996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:2.26 (3.3%) stddev-sans-first:2.39 16:11:39 INFO - PROCESS | 20996 | Values: 68.0 68.0 69.0 74.0 68.0 66.0 70.0 66.0 69.0 69.0 16:11:39 INFO - PROCESS | 20996 | -------- Summary: end -------- 16:11:39 INFO - PROCESS | 20996 | 16:11:40 INFO - TEST-INFO | 20996: exit 0 16:11:40 INFO - TEST-OK | kraken | took 60672ms 16:11:40 INFO - SUITE-END | took 1169s 16:11:40 INFO - Completed test suite (00:19:30) 16:11:40 INFO - javascript benchmark 16:11:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3355.496675498675, 3413.14671332167, 3420.076579323583, 3446.948295775562, 3472.374972504948, 5517.475839795218, 5553.8333849984565, 5558.360788509318, 5580.162975553669, 5580.665160090392, 5573.052581061229, 5582.358028826686, 5615.522680572156, 5617.494425501704, 5653.265075540174, 5096.694198348102, 5112.821051263207, 5177.275181474596, 5188.221766734982, 5198.792048318062, 5021.6735912165595, 5110.080185566597, 5116.974415127919, 5208.401033881095, 5217.034848553011, 5127.769250383742, 5181.0, 5213.765380557884, 5215.1655735082395, 5222.529972302492, 5148.330717006803, 5173.042987047389, 5173.663711858717, 5188.5849132069725, 5201.791928322863, 5008.84973450797, 5037.874053148664, 5051.823186188502, 5065.214891691794, 5100.413452452941, 5328.6802791832615, 5344.732763361816, 5373.462653734634, 5396.082665946759, 5420.620556561043, 5979.671118088503, 5980.372060933583, 5988.431099045583, 5989.970050149765, 5993.041113421875, 5934.465898069195, 5947.910781338283, 6020.397960203988, 6070.908936365958, 6091.42131497507, 5639.68981706006, 5651.576131790132, 5651.604387692863, 5653.462921022497, 5675.0, 6088.665123418166, 6145.047517634774, 6145.8156255312415, 6146.108814222002, 6153.84615384619, 5779.219805326227, 5829.650220986754, 5899.085641725539, 5905.055191169392, 5960.523158147338, 6094.268687757409, 6095.573309868355, 6113.32753397126, 6117.541184411187, 6124.938750612437, 5904.911426328608, 6060.545459090586, 6060.606060606046, 6067.575269731165, 6076.483498902643, 5953.22608060958, 5996.820095397145, 6023.216981792339, 6027.0, 6055.788047418319, 4610.95389046112, 4623.890266336122, 4639.420072490939, 4654.604358629555, 4675.532446755297, 4052.371882358239, 4070.063885306396, 4168.437260969791, 4172.561881002512, 4205.411242426063, 5627.8874422512135, 5669.0, 5763.6541807491685, 5813.331466881363, 5842.532597392198, 6112.17485639433, 6136.140940268366, 6141.263048434216, 6149.169862068653, 6158.1686472326555, 5531.3915469298345, 5665.830025099253, 5715.8856822864145, 5739.684317362502, 5740.225069615632, 5169.353830771153, 5180.844574662766, 5181.766820493087, 5188.45521220274, 5212.40057393397, 6241.96879015602, 6252.5935814171935, 6253.0, 6261.186045814015, 6271.466925311308, 5987.712641782038, 6050.515958723204, 6056.303525094582, 6063.423974722395, 6135.417135372132, 6333.524985626004, 6344.143540622142, 6348.841278968062, 6350.841228969128, 6358.77744278948, 6009.609375390585, 6022.759089636365, 6025.0661147522205, 6026.758929642765, 6042.546808989256, 5933.228680271537, 6069.362716914837, 6109.694515274307, 6117.644716737863, 6155.169052177898, 5880.529557635465, 5962.672053037125, 5963.016102343065, 5970.223870896929, 5982.072778719132, 5912.763489460373, 5934.406559344031, 5974.372690867396, 5979.671118088547, 5981.3719559445635, 5584.329880414376, 5809.390014048464, 5875.383084776208, 5883.94116058834, 5899.705014749159, 5822.883542329045, 5847.707614619167, 5863.032599621015, 5868.2077919480325, 5894.056950887837, 5668.26312579362, 5692.573057020657, 5698.344690360495, 5700.030994730822, 5703.657780533182], "unit": "score", "name": "dojo.html", "value": 5567.280926471464}, {"lowerIsBetter": false, "replicates": [495.707532555792, 570.3127731084044, 587.8677297608036, 600.6876424259385, 608.7017361492868, 31274.0, 40196.59803401965, 40626.390604140885, 40983.59016409835, 41020.0, 44997.7750111249, 45438.318425223646, 45620.315695264515, 45703.0, 45798.0, 8900.866487002684, 9057.864132037992, 9058.728238152833, 9069.682561110363, 9083.137101975302, 8789.604467798965, 8922.955385223066, 8942.73171804847, 8960.059193784657, 9239.122283383067, 9246.306527010467, 9255.444673319622, 9259.074092590754, 9274.304427167956, 9300.116488933574, 9204.355695101312, 9213.0786921308, 9240.630374785, 9249.676261330855, 9284.814303713956, 9039.231665308456, 9210.723678289594, 9210.861837072449, 9225.077492250788, 9233.030531794198, 45426.31860522095, 45637.771811141065, 45816.312755308696, 45958.77020614909, 45961.0, 3578.0, 3600.6039335673054, 3737.1404576947452, 4075.49056367954, 4305.763183024932, 31503.0, 31731.365372692417, 31854.522182167053, 32343.0, 32682.673173268202, 4178.791060446965, 4196.9370459443135, 4212.978935105336, 4217.704760666755, 4229.809658565372, 233013.0, 234500.0, 234662.0, 235498.0, 237417.0, 47344.5265547347, 70910.29089709037, 72093.63953180201, 72487.0, 72604.0, 51796.0, 51805.0, 52243.47756522386, 52320.0, 52338.47661523336, 15915.283812228477, 16176.352945882269, 16178.595535111717, 16190.75713864293, 16220.351185952666, 12811.295378754072, 12881.677958051123, 12996.935015324863, 13021.739565208833, 13088.607341779762, 16147.434839780786, 16353.34586616522, 16433.09617970999, 16474.0, 16486.422975195812, 6473.611583305017, 6543.378379053982, 6584.6830633873415, 6604.900926486107, 6664.5334826561675, 1087.3584585094675, 1112.2103306652207, 1140.984523773842, 1161.3960740415105, 1174.4186627619213, 30952.69047309498, 31011.06966791, 31122.377552449278, 31389.37221255562, 31453.528197077063, 1156.780211759763, 1163.0869767232682, 1168.2231316174818, 1226.4726167747954, 1253.8181963615225, 15834.920825395799, 15922.522324330288, 16049.438269660506, 16467.423640172536, 16693.749593756103, 282875.0, 333694.0, 750143.0, 754228.0, 759993.0, 63911.36088639147, 64815.35184648093, 64870.0, 64874.0, 65042.67478662671, 1444.6749481366608, 1445.0390490323816, 1446.985530144685, 1474.0345073976562, 1501.054335768459, 30778.846105769328, 31984.200394990312, 32397.19007024843, 32679.18302042468, 32723.181920452178, 62388.0, 63738.68130659317, 64357.67821160864, 64398.0, 64479.35520644921, 305910.0, 311214.0, 311429.0, 311547.0, 311816.0, 48531.5146848527, 49249.753751231015, 49351.753241233564, 49631.255531167786, 50211.24683129683, 51534.0, 52661.21008184804, 52664.21003684871, 52753.73623132013, 53883.0, 41343.58656413398, 42670.57329426666, 43365.3495197566, 44228.77885610551, 45012.77493612642, 43352.56647433485, 43426.348604771585, 43801.78099109484, 43849.78075109604, 43903.0, 42735.0, 43589.0, 44073.55926440695, 44291.55708443003, 44423.777881110385, 37156.0, 37225.6277437233, 37275.81362093172, 37427.0, 37574.0, 29023.274418139714, 29397.0, 29499.55750663699, 29552.0, 29619.407611848073], "unit": "score", "name": "ext.html", "value": 20476.578774438098}, {"lowerIsBetter": false, "replicates": [355.3568041844262, 357.6495034865831, 364.5934782717271, 382.62120500704293, 383.52059925093636, 17351.826481735177, 18110.185041673125, 19644.410667679957, 19690.212391504323, 19767.308144214974, 18144.18351174197, 18417.0, 18602.53493662659, 18612.44162675122, 18671.626567468644, 5269.420363759974, 5561.694106824123, 5572.275604171452, 5573.331200255975, 5601.719914004304, 4138.255114079465, 5461.1535212042, 5727.083666613343, 5951.137085122655, 5987.850303742398, 5865.677387743673, 5906.852328691774, 5913.2608423947, 5913.674747888865, 5945.227120474332, 5664.037113690682, 5931.021381472052, 5942.5840191186635, 5943.167956486095, 5960.165576819249, 5191.792328306863, 5204.34945631796, 5215.739213039371, 5241.580673546107, 5256.789728410859, 21400.785992140034, 21467.892660536752, 22170.556588868134, 22359.552808943892, 22386.776132238796, 2138.4653836540865, 2178.575177840322, 2253.076238742124, 2336.941576460585, 2439.195065628356, 10215.642452514126, 10304.845427318596, 10343.534540945675, 10860.6198783043, 12953.28756918369, 1805.0433270366727, 1805.6117934643983, 1893.195391958426, 1940.8350290225349, 1949.1521188283143, 66560.66719666419, 67770.0, 68040.0, 69012.654936725, 69742.0, 9914.40513569188, 10209.591616335412, 10298.0, 10335.431551264603, 10375.792484150426, 14719.852801471849, 14772.704545909022, 14885.181315027561, 14899.03156294859, 14914.328855201542, 7772.494787838886, 7875.133735289228, 7927.643256053491, 7942.285194332538, 8004.439689221698, 7492.662830172655, 7532.623368831537, 7557.697692092364, 7563.092428908456, 7646.23537646242, 4564.42917204884, 4691.272852707836, 4706.1999460091865, 4708.340832283483, 4738.881527961828, 1898.1553208822218, 1951.8731282466879, 1959.4121763470903, 1966.0857701169025, 1971.7831038585743, 988.9208863290919, 1005.3615953869199, 1009.9343542669703, 1044.806710758512, 1091.9727006824894, 15486.22568871552, 17034.0, 17202.053887036334, 17389.0, 17701.822981770274, 931.4271722890373, 997.7555498902815, 1014.8122597319519, 1023.559869256227, 1024.7079582319004, 10022.448765317831, 10141.2394070445, 10141.543630536644, 10172.0, 10328.845067323997, 479268.0, 487198.0, 487201.0, 496222.0, 499641.0, 77194.61402693063, 77583.0, 78884.60557697175, 80592.59406511327, 80654.59672701599, 1027.2141811514198, 1041.7083216699336, 1050.1179009631794, 1089.0470838016736, 1099.197585762398, 15968.680626387175, 16031.519054428385, 16111.436099736453, 16268.349266029227, 16332.101734404721, 25638.743612563634, 35139.64860351364, 36052.8197359022, 36551.634483655886, 36971.07572310714, 51174.0, 52208.0, 53010.73494632502, 53024.0, 53069.73465132649, 8021.27808497238, 8142.8778568322705, 8151.633176506953, 8199.385046121446, 8358.623861926106, 9574.712758617252, 11225.214235003472, 12377.195482293622, 12517.687057823627, 12530.498780048696, 9945.204383649147, 10051.396916185053, 10201.54093065799, 10402.427866467417, 10671.94664026675, 10434.895651043393, 10659.200559957879, 10701.678949631523, 10744.409057501913, 10827.0, 10264.948675256575, 10271.6103685785, 10662.520186591466, 10780.093679154117, 10901.236913415985, 8154.429189956646, 8264.710735124241, 8320.958395207985, 8326.62530186131, 8394.076651568445, 9657.32398732082, 9953.452560109263, 10470.947645261725, 10493.580256789948, 10870.293430926964], "unit": "score", "name": "jquery.html", "value": 8747.286849925404}, {"lowerIsBetter": false, "replicates": [1607.5177446765967, 1630.4537979776771, 1882.2753240002603, 1973.901304934753, 2007.558337165824, 7763.223677632234, 8424.789380265496, 8455.281301089408, 8676.262517686004, 8690.608922598474, 8387.454815437008, 8401.327893768499, 8486.321094312456, 8496.575171241444, 8508.787280317994, 2411.1922505960524, 2435.2815919303757, 2440.9145679901208, 2440.987795061022, 2444.8655323957173, 2308.503671710582, 2340.4382948092507, 2346.753590872959, 2348.0, 2348.906043758256, 2408.217329367954, 2433.0146290752273, 2450.3629056445275, 2450.5098980203943, 2457.7910877575428, 2392.3301475586863, 2401.387646150238, 2414.5291668124723, 2416.8429052111555, 2456.852588844675, 2377.358113309414, 2391.0794344177443, 2395.401149712572, 2401.5557121932497, 2421.1041914491575, 8661.956690216508, 8683.522406267653, 8690.869636955451, 8691.739247822576, 8724.34567407447, 5193.870153246161, 5270.051390749663, 5320.334958130234, 5347.572194224492, 5363.0, 3038.7417069549115, 3059.521787352252, 3096.9315586122975, 3161.8577164027674, 3209.3420848725955, 881.5988725130051, 890.7951171230588, 894.1014280647908, 908.0238743350858, 917.9357444978854, 12219.816702749466, 12279.447424865992, 12312.322822244772, 12354.0, 12355.938220308932, 4591.678582499193, 4617.815287388534, 4638.95361046392, 4664.86005419838, 4745.074710431432, 10380.0, 10405.635802746867, 10411.947940260401, 10417.166626669848, 10440.269181157246, 5384.219288203189, 5407.080796264644, 5412.700951771625, 5415.83752487426, 5452.890942181134, 4206.348016057516, 4638.1883170445035, 4677.18149323867, 4699.177643912301, 4886.584640305614, 3847.442120892455, 3857.228554289153, 3891.2606604745006, 3904.550976637723, 3920.2159568086495, 1228.2384921348641, 1242.2298175131477, 1242.3043095866344, 1247.8876901078947, 1262.9052821038458, 1212.1575505023923, 1220.2251570252777, 1230.7476967221698, 1504.8645621894082, 1522.3453914816514, 7749.573773442402, 7844.725434609875, 7917.920820791834, 7958.08482024563, 8369.707060252862, 1219.908506861971, 1222.2727477151082, 1226.8405107336168, 1243.6952946528158, 1264.8608653048157, 6463.450606698483, 6479.319671434431, 6503.2521260054755, 6506.512011599149, 6573.769918052845, 10269.94865025685, 10607.734806629896, 10617.522211500347, 10627.521761520595, 10693.144548436261, 10264.897351026544, 10381.636642717469, 10487.528061237263, 10512.474376281156, 10513.684589462327, 8248.422610417214, 8263.173682631808, 8292.958535207406, 8384.161583841567, 8401.663933442716, 7893.447458678067, 7991.0, 8020.0375954885785, 8081.353491720531, 8087.919120808717, 9000.459972401677, 9101.908980910372, 9123.361364704408, 9147.176754092163, 9194.26445884341, 9297.67458138962, 9412.905870941204, 9576.952115239379, 9593.0, 9790.804183916423, 6714.127163468718, 7392.778216653509, 7571.545707257582, 7574.697012119674, 7604.0, 8263.297619702393, 8280.337572994267, 8295.958520207601, 8306.501609903184, 8315.293200078062, 7042.330978557029, 7173.892391614026, 7269.055022846996, 7337.74317898871, 7367.042284502981, 6924.376806087476, 6928.16861976566, 6988.615626140611, 7073.504854660125, 7145.249748776304, 7690.846183076419, 7837.216278372117, 7870.645820938186, 7870.72452464161, 7871.448998570274, 7132.500724949204, 7155.713771449292, 7234.5659260444545, 7240.05879235717, 7243.782686519413, 7163.677634506564, 7258.818529536804, 7266.6729997151315, 7267.890981635385, 7275.017872587345], "unit": "score", "name": "mootools.html", "value": 4893.767843239076}, {"lowerIsBetter": false, "replicates": [329.89443378118995, 330.7023678689181, 330.7982130900152, 338.83735806812723, 344.74316634107583, 6361.650109244001, 6374.776882809103, 6402.935970640292, 6448.61308321501, 6450.870982580352, 6260.092286618437, 6262.906056409146, 6305.590136641115, 6305.905411418832, 6339.36606339367, 4531.161735079021, 4719.9292010619865, 4800.135975524396, 4833.492483289257, 4847.224444088946, 4840.370751802261, 4848.369711937461, 4859.271109333593, 4862.927056094161, 4871.5615594596475, 4795.832145874895, 4809.206480930642, 4814.87962800931, 4821.4696383397795, 4832.73419961902, 4785.569298763093, 4820.156472617296, 4826.927596086061, 4843.733594652293, 4847.3213750074665, 4239.173361194568, 4242.851500197478, 4249.617534421886, 4256.553061928484, 4258.488981322261, 5805.216295800055, 6003.6397816131175, 6008.969955150196, 6014.188084608566, 6017.127516510125, 5505.862353441156, 5528.281323427969, 5536.363318218416, 5539.058360078796, 5540.141278101901, 6623.238327592292, 6680.699368528428, 6683.030960510699, 6688.063671086052, 6697.22981857083, 4530.071335376273, 4559.042601053749, 4564.2240819060835, 4564.292534657134, 4568.291914753218, 6897.862042759167, 6966.02475653414, 6975.267596902354, 6980.581165130108, 6989.5456795308655, 4523.36672865799, 4550.34020067095, 4585.885352866205, 4587.082583483317, 4698.906021879543, 4711.7879695413785, 4718.575328220477, 4752.0, 4753.786079626425, 4775.331453596499, 5474.452554744574, 5497.422770609109, 5504.504594586427, 5518.668879867221, 5519.116941289374, 6676.399124078759, 6689.163854518185, 6704.195496540349, 6711.932880671228, 6729.831754206086, 1664.2926756128838, 1687.8902871313326, 1692.6445446456137, 1693.2803558487594, 1698.6178109925168, 1037.1443559063803, 1067.124957534814, 1070.769784496337, 1073.3774410841693, 1088.0588291128117, 6442.098106265126, 6460.58006229603, 6482.222133344029, 6503.447206987365, 6516.934830651633, 6868.896966545506, 6874.828129296808, 6893.310668933066, 6899.93100069003, 6911.274316196827, 6427.453666438405, 6526.086347911296, 6544.672766361663, 6549.050387693853, 6603.834904127435, 3758.680512156497, 3783.7729736215915, 3796.2787070457075, 3800.9809950950066, 3815.198808250243, 7312.561246325237, 7353.117625884928, 7358.742444014434, 7360.33756961876, 7370.078740157481, 7137.89293160603, 7147.428205743528, 7159.821004474826, 7177.820554486075, 7208.4954053216825, 6997.510174287751, 7286.927130728731, 7303.087114110736, 7342.743003994835, 7375.336219740142, 6960.408365288805, 6977.7208911642965, 6978.581285122909, 6992.1958974718555, 6992.895106573304, 6870.27862074495, 6870.484713646597, 6872.656367181721, 6876.621785801829, 6887.483438742014, 7242.782716518513, 7290.453216008927, 7319.268073192638, 7328.560286382834, 7382.114146302478, 4641.535846415331, 4723.574878260973, 4731.29030645406, 4739.810407583658, 4749.786259618395, 7018.122734658168, 7027.789166325018, 7029.156501219886, 7030.683619237045, 7031.683574239274, 6828.385445309946, 6843.247242803188, 6855.760048398282, 6868.656567171522, 6886.139232595926, 6808.93191068083, 6809.182898052265, 6819.863602728017, 6831.6242606657115, 6868.278830722702, 6586.868262634624, 6619.709156714394, 6665.100211471389, 6691.76578819739, 6710.6309152997055, 6778.525503214925, 6782.762603308861, 6783.626900520321, 6804.11546498952, 6827.658617069226, 6562.0, 6578.309277525982, 6582.078509008838, 6629.0, 6649.567778094602], "unit": "score", "name": "prototype.html", "value": 5053.983902648977}, {"lowerIsBetter": false, "replicates": [773.7949443397497, 775.9961200194, 776.0493395590399, 825.8348330333931, 884.2704768565933, 12135.575254866082, 14740.33668484918, 14973.401063957455, 15103.773443398359, 15117.092974421528, 13288.867111328884, 13303.068785185042, 13410.530631427902, 13463.326833658302, 13507.72984540311, 914.1955079530037, 931.9767005824875, 941.2658126661181, 962.1004360922525, 964.5996911281844, 958.2190514730472, 960.5149399553216, 960.524540352523, 962.0716009051264, 964.7732782796037, 980.9950950245238, 993.9701808945707, 996.8155891160122, 997.2670087485692, 997.4264797741328, 984.7045886234173, 985.074030411411, 985.1035557642547, 990.1534188268998, 991.3011327014437, 731.8572878288736, 734.4638413957788, 734.6436978065634, 735.2500449541491, 735.9411247100219, 13647.249401282925, 13740.10689305202, 13833.170009799444, 13833.239171845646, 13868.237246951414, 12579.496820127184, 12580.68548286291, 12592.685182870502, 12736.490540378374, 12907.0, 10543.156547476183, 10576.365418074864, 10730.087942524895, 10760.515776790064, 10773.245872788908, 3661.359262129117, 3768.8492460301554, 3770.0951771574623, 3789.5452545694416, 3806.2958352704836, 52385.73807130978, 52680.0, 53277.200841987404, 53294.0, 53798.0, 9766.36518626287, 9791.314607977516, 10059.094681478702, 10112.696619101438, 10276.126529245097, 16792.0, 16830.074345911093, 16862.494125176265, 16913.408030718867, 16985.830141698672, 7205.099362579677, 7255.274472552703, 7338.192798792129, 7378.778636640909, 7464.178940316561, 4150.27370210212, 4220.810063547147, 4240.787960601958, 4267.445232119804, 4326.935095973563, 3172.968270317267, 3199.216192032967, 3203.1351535085396, 3204.5193221017034, 3205.7916235444623, 573.3521121133093, 582.051256451989, 583.3670467542679, 583.6118980877669, 585.3297973819953, 563.706872426336, 585.3356440440131, 621.273110460762, 636.726207730671, 644.1883227133845, 7946.324562412144, 8358.582070896431, 8486.618102185417, 8493.108223636553, 8537.701180458655, 593.7150167919336, 693.7537174303151, 713.0765658472291, 713.4328209073799, 719.7444907058024, 3818.4585443748374, 3821.331267028259, 3872.0707030312524, 3876.5154355705536, 3920.627540383659, 58204.41795582075, 58258.4174158253, 59067.0, 59071.40928590745, 59136.0, 52252.21621675678, 52715.47284527183, 53342.199867002026, 53519.464805352225, 54326.728366357915, 48261.5173848257, 51934.0, 53275.467245327054, 54347.0, 54832.72583637056, 8502.659893604186, 8545.914540854512, 8579.227869491775, 8583.527905965231, 8742.344324175585, 35589.64410355863, 35664.643353566134, 35902.461463078595, 36581.817090914374, 37570.624293756715, 41654.79172604118, 45997.0, 46603.53396465992, 46637.06725865532, 46792.08683088227, 10066.949665251626, 10080.596776128872, 10277.537510811882, 10361.948190259302, 10546.525406356886, 10919.945400272947, 10935.234533582572, 10987.725306867393, 10993.0, 11038.668839934815, 10509.894901050891, 10569.841452378374, 10573.04842564173, 10578.947105264733, 10669.839952400565, 10653.467326633483, 10834.187435942178, 10871.184661150288, 10970.945145274223, 11017.944910275397, 10367.170626350025, 10368.844467333147, 10397.272190946562, 10508.894911050791, 10731.946340268249, 9207.58565864551, 9278.536073196177, 9350.859737103812, 9409.811803764023, 9418.340716149803, 9132.223760980125, 9757.707268781947, 9782.951085244527, 9783.168430683472, 9790.007818063292], "unit": "score", "name": "yui.html", "value": 6455.5242216896795}], "name": "dromaeo_css", "value": 7362.1260672508915}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 105.0, 114.0, 110.0, 111.0, 135.0, 114.0, 109.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 151.0, 174.0, 137.0, 154.0, 167.0, 129.0, 172.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 162.0, 163.0, 164.0, 163.0, 161.0, 162.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 76.0, 171.0, 77.0, 77.0, 74.0, 77.0, 170.0, 75.0], "unit": "score", "name": "audio-fft", "value": 94.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 149.0, 94.0, 94.0, 93.0, 146.0, 93.0, 94.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 108.6}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 119.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.6}, {"lowerIsBetter": true, "replicates": [146.0, 150.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [54.0, 56.0, 56.0, 59.0, 55.0, 58.0, 57.0, 65.0, 58.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 66.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [80.0, 81.0, 93.0, 79.0, 80.0, 89.0, 82.0, 80.0, 81.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [111.0, 113.0, 116.0, 121.0, 115.0, 120.0, 118.0, 113.0, 120.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [139.0, 147.0, 147.0, 144.0, 157.0, 145.0, 147.0, 145.0, 146.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 74.0, 68.0, 66.0, 70.0, 66.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1526.1000000000001}]} 16:11:40 INFO - Return code: 0 16:11:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:11:40 ERROR - # TBPL SUCCESS # 16:11:40 INFO - Running post-action listener: _resource_record_post_action 16:11:40 INFO - Running post-run listener: _resource_record_post_run 16:11:41 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 261726208; Read time: 152; Write time: 206900 16:11:41 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14426112; Read time: 0; Write time: 28008 16:11:41 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 246341632; Read time: 152; Write time: 178840 16:11:41 INFO - Running post-run listener: _upload_blobber_files 16:11:41 INFO - Blob upload gear active. 16:11:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:11:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:11:41 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:11:41 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:11:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:11:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:43 INFO - (blobuploader) - INFO - Done attempting. 16:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:11:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:44 INFO - (blobuploader) - INFO - Done attempting. 16:11:44 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:44 INFO - Return code: 0 16:11:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:11:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1c821a85ee9431736e59cfec81f90083d252d46c6bb352ab7789af0e767618328faf2927a3e948a43f45b3da45a0528fb5b23761173b1d2d6f8f260baf8fd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd83c08ae0248c9cf7c26521d1e028fb211825f34def4252d8559101b2e79f3d369f2d9e3be59ab7c88b2759dd81683cfbd9241cbece7af5050434633582ad42"} 16:11:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:11:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:11:44 INFO - Contents: 16:11:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1c821a85ee9431736e59cfec81f90083d252d46c6bb352ab7789af0e767618328faf2927a3e948a43f45b3da45a0528fb5b23761173b1d2d6f8f260baf8fd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd83c08ae0248c9cf7c26521d1e028fb211825f34def4252d8559101b2e79f3d369f2d9e3be59ab7c88b2759dd81683cfbd9241cbece7af5050434633582ad42"} 16:11:44 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:44 INFO - Copying logs to upload dir... 16:11:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 16:11:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1515.844037 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 15 secs) (at 2016-04-06 16:11:43.457647) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 16:11:43.461628) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 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-Aurora/sha512/7a1c821a85ee9431736e59cfec81f90083d252d46c6bb352ab7789af0e767618328faf2927a3e948a43f45b3da45a0528fb5b23761173b1d2d6f8f260baf8fd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd83c08ae0248c9cf7c26521d1e028fb211825f34def4252d8559101b2e79f3d369f2d9e3be59ab7c88b2759dd81683cfbd9241cbece7af5050434633582ad42"} build_url:https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/LTgSnKi6SmKiRJqfyFNaFA/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7a1c821a85ee9431736e59cfec81f90083d252d46c6bb352ab7789af0e767618328faf2927a3e948a43f45b3da45a0528fb5b23761173b1d2d6f8f260baf8fd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/fd83c08ae0248c9cf7c26521d1e028fb211825f34def4252d8559101b2e79f3d369f2d9e3be59ab7c88b2759dd81683cfbd9241cbece7af5050434633582ad42"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 16:11:43.486658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:11:43.486977) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1459982784.77230-416266682 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:11:43.573584) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 16:11:43.574488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 16:11:43.575084) ========= ========= Total master_lag: 0.39 =========