builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1454739072.65 results: success (0) buildid: 20160205193440 builduid: 235fd22f6fd54e0dbafd6e21a591c52e revision: 0885625045f0d07ab8ce6d46d8b354939aa3b617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.649974) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.650381) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.650670) ========= 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.679342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.679612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.695669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.695945) ========= 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004694 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.748229) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.748519) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.748891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:12.749160) ========= 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-05 22:11:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-02-05 22:11:13 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.407209 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.168301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.168594) ========= 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018293 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.217583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.217951) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0885625045f0d07ab8ce6d46d8b354939aa3b617 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0885625045f0d07ab8ce6d46d8b354939aa3b617 --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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-05 22:11:13,542 truncating revision to first 12 chars 2016-02-05 22:11:13,542 Setting DEBUG logging. 2016-02-05 22:11:13,542 attempt 1/10 2016-02-05 22:11:13,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0885625045f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-05 22:11:13,806 unpacking tar archive at: mozilla-central-0885625045f0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554454 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.785119) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.785621) ========= echo 0885625045f0d07ab8ce6d46d8b354939aa3b617 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0885625045f0d07ab8ce6d46d8b354939aa3b617'] 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0885625045f0d07ab8ce6d46d8b354939aa3b617 program finished with exit code 0 elapsedTime=0.004419 script_repo_revision: '0885625045f0d07ab8ce6d46d8b354939aa3b617' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.836248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.836540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 22:11:13.845919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-02-05 22:11:13.846184) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:11:14 INFO - MultiFileLogger online at 20160205 22:11:14 in /builds/slave/test-pgo 22:11:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 22:11:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:11:14 INFO - {'append_to_log': False, 22:11:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:11:14 INFO - 'blob_upload_branch': 'Firefox', 22:11:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:11:14 INFO - 'branch': 'Firefox', 22:11:14 INFO - 'buildbot_json_path': 'buildprops.json', 22:11:14 INFO - 'config_files': ('talos/linux_config.py',), 22:11:14 INFO - 'default_actions': ('clobber', 22:11:14 INFO - 'read-buildbot-config', 22:11:14 INFO - 'download-and-extract', 22:11:14 INFO - 'populate-webroot', 22:11:14 INFO - 'create-virtualenv', 22:11:14 INFO - 'install', 22:11:14 INFO - 'run-tests'), 22:11:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:11:14 INFO - 'download_minidump_stackwalk': True, 22:11:14 INFO - 'download_symbols': 'ondemand', 22:11:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:11:14 INFO - 'tooltool.py': '/tools/tooltool.py', 22:11:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:11:14 INFO - '/tools/misc-python/virtualenv.py')}, 22:11:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:11:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:11:14 INFO - 'installer_path': 'installer.exe', 22:11:14 INFO - 'log_level': 'info', 22:11:14 INFO - 'log_name': 'talos', 22:11:14 INFO - 'log_to_console': True, 22:11:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:11:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:11:14 INFO - 'opt_config_files': (), 22:11:14 INFO - 'pip_index': False, 22:11:14 INFO - 'sps_profile': False, 22:11:14 INFO - 'sps_profile_interval': 0, 22:11:14 INFO - 'suite': 'dromaeojs-e10s', 22:11:14 INFO - 'system_bits': '32', 22:11:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:11:14 INFO - 'title': 'talos-linux64-ix-053', 22:11:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:11:14 INFO - 'use_talos_json': True, 22:11:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:11:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:11:14 INFO - 'work_dir': 'build'} 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running clobber step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: clobber 22:11:14 INFO - rmtree: /builds/slave/test-pgo/build 22:11:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:11:14 INFO - Running post-action listener: _resource_record_post_action 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running read-buildbot-config step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: read_buildbot_config 22:11:14 INFO - Using buildbot properties: 22:11:14 INFO - { 22:11:14 INFO - "project": "", 22:11:14 INFO - "product": "firefox", 22:11:14 INFO - "script_repo_revision": "production", 22:11:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:11:14 INFO - "repository": "", 22:11:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:11:14 INFO - "buildid": "20160205193440", 22:11:14 INFO - "pgo_build": "True", 22:11:14 INFO - "basedir": "/builds/slave/test-pgo", 22:11:14 INFO - "buildnumber": 350, 22:11:14 INFO - "slavename": "talos-linux64-ix-053", 22:11:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:11:14 INFO - "platform": "ubuntu64_hw", 22:11:14 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 22:11:14 INFO - "branch": "mozilla-central", 22:11:14 INFO - "repo_path": "mozilla-central", 22:11:14 INFO - "revision": "0885625045f0d07ab8ce6d46d8b354939aa3b617", 22:11:14 INFO - "stage_platform": "linux64-pgo", 22:11:14 INFO - "builduid": "235fd22f6fd54e0dbafd6e21a591c52e", 22:11:14 INFO - "slavebuilddir": "test" 22:11:14 INFO - } 22:11:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 22:11:14 INFO - Running post-action listener: _resource_record_post_action 22:11:14 INFO - ##### 22:11:14 INFO - ##### Running download-and-extract step. 22:11:14 INFO - ##### 22:11:14 INFO - Running pre-action listener: _resource_record_pre_action 22:11:14 INFO - Running main action method: download_and_extract 22:11:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:11:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:14 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:11:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json 22:11:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json 22:11:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:11:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:11:16 INFO - Downloaded 1448 bytes. 22:11:16 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:11:16 INFO - Using the following test package requirements: 22:11:16 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:16 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:11:16 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:11:16 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'jsshell-linux-x86_64.zip'], 22:11:16 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:11:16 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:16 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:11:16 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:11:16 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:11:16 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 22:11:16 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 22:11:16 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:11:16 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:11:16 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')]} 22:11:16 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:17 INFO - Downloaded 23573602 bytes. 22:11:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:11:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:11:18 INFO - Return code: 0 22:11:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:11:18 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')]} 22:11:18 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:11:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 22:11:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:11:20 INFO - Downloaded 23573602 bytes. 22:11:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:11:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:11:22 INFO - Return code: 0 22:11:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:22 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:11:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 22:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:11:23 INFO - Downloaded 10706547 bytes. 22:11:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:11:23 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:11:23 INFO - Return code: 0 22:11:23 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')]} 22:11:23 INFO - https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:11:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:11:24 INFO - Downloaded 56575815 bytes. 22:11:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:24 INFO - mkdir: /builds/slave/test-pgo/properties 22:11:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:11:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:11:24 INFO - Contents: 22:11:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 22:11:25 INFO - Running post-action listener: _resource_record_post_action 22:11:25 INFO - Running post-action listener: set_extra_try_arguments 22:11:25 INFO - ##### 22:11:25 INFO - ##### Running populate-webroot step. 22:11:25 INFO - ##### 22:11:25 INFO - Running pre-action listener: _resource_record_pre_action 22:11:25 INFO - Running main action method: populate_webroot 22:11:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:11:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:11:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:11:25 INFO - '--tppagecycles', 22:11:25 INFO - '7'], 22:11:25 INFO - 'tests': ['tsvgm']}}, 22:11:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:11:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:11:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 22:11:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:11:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:11:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'tests': ['damp', 'tps']}, 22:11:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['damp', 'tps']}, 22:11:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:11:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:11:25 INFO - 'other': {'tests': ['a11yr', 22:11:25 INFO - 'ts_paint', 22:11:25 INFO - 'tpaint', 22:11:25 INFO - 'sessionrestore', 22:11:25 INFO - 'sessionrestore_no_auto_restore']}, 22:11:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['a11yr', 22:11:25 INFO - 'ts_paint', 22:11:25 INFO - 'tpaint', 22:11:25 INFO - 'sessionrestore', 22:11:25 INFO - 'sessionrestore_no_auto_restore']}, 22:11:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['a11yr', 22:11:25 INFO - 'ts_paint', 22:11:25 INFO - 'tpaint', 22:11:25 INFO - 'sessionrestore', 22:11:25 INFO - 'sessionrestore_no_auto_restore']}, 22:11:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['a11yr', 22:11:25 INFO - 'ts_paint', 22:11:25 INFO - 'tpaint', 22:11:25 INFO - 'sessionrestore', 22:11:25 INFO - 'sessionrestore_no_auto_restore']}, 22:11:25 INFO - 'other_l64': {'tests': ['a11yr', 22:11:25 INFO - 'ts_paint', 22:11:25 INFO - 'tpaint', 22:11:25 INFO - 'sessionrestore', 22:11:25 INFO - 'sessionrestore_no_auto_restore']}, 22:11:25 INFO - 'other_nol64': {'tests': ['a11yr', 22:11:25 INFO - 'ts_paint', 22:11:25 INFO - 'tpaint', 22:11:25 INFO - 'sessionrestore', 22:11:25 INFO - 'sessionrestore_no_auto_restore']}, 22:11:25 INFO - 'svgr': {'tests': ['tsvgx', 22:11:25 INFO - 'tsvgr_opacity', 22:11:25 INFO - 'tart', 22:11:25 INFO - 'tscrollx', 22:11:25 INFO - 'cart']}, 22:11:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['tsvgx', 22:11:25 INFO - 'tsvgr_opacity', 22:11:25 INFO - 'tart', 22:11:25 INFO - 'tscrollx', 22:11:25 INFO - 'cart']}, 22:11:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'tests': ['tp5o']}, 22:11:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'talos_options': ['--e10s'], 22:11:25 INFO - 'tests': ['tp5o']}, 22:11:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'talos_options': ['--xperf_path', 22:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:25 INFO - 'tests': ['tp5n']}, 22:11:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:11:25 INFO - 'talos_options': ['--e10s', 22:11:25 INFO - '--xperf_path', 22:11:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:11:25 INFO - 'tests': ['tp5n']}}, 22:11:25 INFO - 'talos.zip': {'path': '', 22:11:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:11:25 INFO - Running post-action listener: _resource_record_post_action 22:11:25 INFO - ##### 22:11:25 INFO - ##### Running create-virtualenv step. 22:11:25 INFO - ##### 22:11:25 INFO - Running pre-action listener: _resource_record_pre_action 22:11:25 INFO - Running main action method: create_virtualenv 22:11:25 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:11:25 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 22:11:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:11:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:11:25 INFO - Using real prefix '/usr' 22:11:25 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:11:25 INFO - Installing distribute.............................................................................................................................................................................................done. 22:11:27 INFO - Installing pip.................done. 22:11:27 INFO - Return code: 0 22:11:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:27 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:27 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 22:11:27 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 22:11:27 INFO - Using env: {'DISPLAY': ':0', 22:11:27 INFO - 'HOME': '/home/cltbld', 22:11:27 INFO - 'LANG': 'en_US.UTF-8', 22:11:27 INFO - 'LANGUAGE': 'en_US:en', 22:11:27 INFO - 'LOGNAME': 'cltbld', 22:11:27 INFO - 'MAIL': '/var/mail/cltbld', 22:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:27 INFO - 'MOZ_NO_REMOTE': '1', 22:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:27 INFO - 'NO_EM_RESTART': '1', 22:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:27 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:27 INFO - 'SHELL': '/bin/bash', 22:11:27 INFO - 'SHLVL': '1', 22:11:27 INFO - 'TERM': 'linux', 22:11:27 INFO - 'TMOUT': '86400', 22:11:27 INFO - 'USER': 'cltbld', 22:11:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:27 INFO - '_': '/tools/buildbot/bin/python'} 22:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:28 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 22:11:28 INFO - Cleaning up... 22:11:28 INFO - Return code: 0 22:11:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:11:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:11:28 INFO - Using env: {'DISPLAY': ':0', 22:11:28 INFO - 'HOME': '/home/cltbld', 22:11:28 INFO - 'LANG': 'en_US.UTF-8', 22:11:28 INFO - 'LANGUAGE': 'en_US:en', 22:11:28 INFO - 'LOGNAME': 'cltbld', 22:11:28 INFO - 'MAIL': '/var/mail/cltbld', 22:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:28 INFO - 'MOZ_NO_REMOTE': '1', 22:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:28 INFO - 'NO_EM_RESTART': '1', 22:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:28 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:28 INFO - 'SHELL': '/bin/bash', 22:11:28 INFO - 'SHLVL': '1', 22:11:28 INFO - 'TERM': 'linux', 22:11:28 INFO - 'TMOUT': '86400', 22:11:28 INFO - 'USER': 'cltbld', 22:11:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:28 INFO - '_': '/tools/buildbot/bin/python'} 22:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:28 INFO - Downloading/unpacking psutil>=0.7.1 22:11:28 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 22:11:28 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 22:11:28 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 22:11:28 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 22:11:28 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 22:11:28 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 22:11:30 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:30 INFO - Installing collected packages: psutil 22:11:30 INFO - Running setup.py install for psutil 22:11:30 INFO - building 'psutil._psutil_linux' extension 22:11:30 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 22:11:30 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 22:11:30 INFO - building 'psutil._psutil_posix' extension 22:11:30 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 22:11:30 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 22:11:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:11:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:11:30 INFO - Successfully installed psutil 22:11:30 INFO - Cleaning up... 22:11:30 INFO - Return code: 0 22:11:30 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:30 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:30 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 22:11:30 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 22:11:30 INFO - Using env: {'DISPLAY': ':0', 22:11:30 INFO - 'HOME': '/home/cltbld', 22:11:30 INFO - 'LANG': 'en_US.UTF-8', 22:11:30 INFO - 'LANGUAGE': 'en_US:en', 22:11:30 INFO - 'LOGNAME': 'cltbld', 22:11:30 INFO - 'MAIL': '/var/mail/cltbld', 22:11:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:30 INFO - 'MOZ_NO_REMOTE': '1', 22:11:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:30 INFO - 'NO_EM_RESTART': '1', 22:11:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:30 INFO - 'SHELL': '/bin/bash', 22:11:30 INFO - 'SHLVL': '1', 22:11:30 INFO - 'TERM': 'linux', 22:11:30 INFO - 'TMOUT': '86400', 22:11:30 INFO - 'USER': 'cltbld', 22:11:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:30 INFO - '_': '/tools/buildbot/bin/python'} 22:11:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:11:30 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 22:11:30 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 22:11:30 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 22:11:30 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 22:11:30 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 22:11:30 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 22:11:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:11:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:11:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:11:32 INFO - Installing collected packages: mozsystemmonitor 22:11:32 INFO - Running setup.py install for mozsystemmonitor 22:11:32 INFO - Successfully installed mozsystemmonitor 22:11:32 INFO - Cleaning up... 22:11:32 INFO - Return code: 0 22:11:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:11: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')]} 22:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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', '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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:11: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 blobuploader==1.2.4 22:11:32 INFO - Using env: {'DISPLAY': ':0', 22:11:32 INFO - 'HOME': '/home/cltbld', 22:11:32 INFO - 'LANG': 'en_US.UTF-8', 22:11:32 INFO - 'LANGUAGE': 'en_US:en', 22:11:32 INFO - 'LOGNAME': 'cltbld', 22:11:32 INFO - 'MAIL': '/var/mail/cltbld', 22:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:32 INFO - 'MOZ_NO_REMOTE': '1', 22:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:32 INFO - 'NO_EM_RESTART': '1', 22:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:32 INFO - 'SHELL': '/bin/bash', 22:11:32 INFO - 'SHLVL': '1', 22:11:32 INFO - 'TERM': 'linux', 22:11:32 INFO - 'TMOUT': '86400', 22:11:32 INFO - 'USER': 'cltbld', 22:11:32 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:32 INFO - '_': '/tools/buildbot/bin/python'} 22:11:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:33 INFO - Downloading/unpacking blobuploader==1.2.4 22:11:33 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 22:11:33 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 22:11:33 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 22:11:33 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 22:11:33 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 22:11:33 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 22:11:34 INFO - Downloading blobuploader-1.2.4.tar.gz 22:11:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:11:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:11:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:35 INFO - Downloading docopt-0.6.1.tar.gz 22:11:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:11:35 INFO - Installing collected packages: blobuploader, requests, docopt 22:11:35 INFO - Running setup.py install for blobuploader 22:11:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:11:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:11:35 INFO - Running setup.py install for requests 22:11:36 INFO - Running setup.py install for docopt 22:11:36 INFO - Successfully installed blobuploader requests docopt 22:11:36 INFO - Cleaning up... 22:11:36 INFO - Return code: 0 22:11:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:11:36 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')]} 22:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:36 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')]} 22:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:36 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:36 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 22:11:36 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 22:11:36 INFO - Using env: {'DISPLAY': ':0', 22:11:36 INFO - 'HOME': '/home/cltbld', 22:11:36 INFO - 'LANG': 'en_US.UTF-8', 22:11:36 INFO - 'LANGUAGE': 'en_US:en', 22:11:36 INFO - 'LOGNAME': 'cltbld', 22:11:36 INFO - 'MAIL': '/var/mail/cltbld', 22:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:36 INFO - 'MOZ_NO_REMOTE': '1', 22:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:36 INFO - 'NO_EM_RESTART': '1', 22:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:36 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:36 INFO - 'SHELL': '/bin/bash', 22:11:36 INFO - 'SHLVL': '1', 22:11:36 INFO - 'TERM': 'linux', 22:11:36 INFO - 'TMOUT': '86400', 22:11:36 INFO - 'USER': 'cltbld', 22:11:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:36 INFO - '_': '/tools/buildbot/bin/python'} 22:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:36 INFO - Running setup.py (path:/tmp/pip-0U9p3G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:36 INFO - Running setup.py (path:/tmp/pip-0QepT4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:36 INFO - Running setup.py (path:/tmp/pip-fooEM7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:36 INFO - Running setup.py (path:/tmp/pip-Zj9v0V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:36 INFO - Running setup.py (path:/tmp/pip-g3FIgo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:36 INFO - Running setup.py (path:/tmp/pip-YN72eG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:36 INFO - Running setup.py (path:/tmp/pip-HOKLMo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:36 INFO - Running setup.py (path:/tmp/pip-yhzAze-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:37 INFO - Running setup.py (path:/tmp/pip-RQwk6o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:37 INFO - Running setup.py (path:/tmp/pip-W8_BLn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:37 INFO - Running setup.py (path:/tmp/pip-kFIILI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:37 INFO - Running setup.py (path:/tmp/pip-QncIO2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:37 INFO - Running setup.py (path:/tmp/pip-MgcjzR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:37 INFO - Running setup.py (path:/tmp/pip-TnG_G8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:37 INFO - Running setup.py (path:/tmp/pip-uD1Icg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:37 INFO - Running setup.py (path:/tmp/pip-w6UOzx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:37 INFO - Running setup.py (path:/tmp/pip-8e98Qq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:11:37 INFO - Running setup.py install for manifestparser 22:11:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:11:37 INFO - Running setup.py install for mozcrash 22:11:37 INFO - Running setup.py install for mozdebug 22:11:37 INFO - Running setup.py install for mozdevice 22:11:38 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Running setup.py install for mozfile 22:11:38 INFO - Running setup.py install for mozhttpd 22:11:38 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Running setup.py install for mozinfo 22:11:38 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Running setup.py install for mozInstall 22:11:38 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Running setup.py install for mozleak 22:11:38 INFO - Running setup.py install for mozlog 22:11:38 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Running setup.py install for moznetwork 22:11:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:11:38 INFO - Running setup.py install for mozprocess 22:11:38 INFO - Running setup.py install for mozprofile 22:11:39 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:11:39 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:11:39 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:11:39 INFO - Running setup.py install for mozrunner 22:11:39 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:11:39 INFO - Running setup.py install for mozscreenshot 22:11:39 INFO - Running setup.py install for moztest 22:11:39 INFO - Running setup.py install for mozversion 22:11:39 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:11:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:11:39 INFO - Cleaning up... 22:11:39 INFO - Return code: 0 22:11:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:39 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:39 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 22:11:39 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 22:11:39 INFO - Using env: {'DISPLAY': ':0', 22:11:39 INFO - 'HOME': '/home/cltbld', 22:11:39 INFO - 'LANG': 'en_US.UTF-8', 22:11:39 INFO - 'LANGUAGE': 'en_US:en', 22:11:39 INFO - 'LOGNAME': 'cltbld', 22:11:39 INFO - 'MAIL': '/var/mail/cltbld', 22:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:39 INFO - 'MOZ_NO_REMOTE': '1', 22:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:39 INFO - 'NO_EM_RESTART': '1', 22:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:39 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:39 INFO - 'SHELL': '/bin/bash', 22:11:39 INFO - 'SHLVL': '1', 22:11:39 INFO - 'TERM': 'linux', 22:11:39 INFO - 'TMOUT': '86400', 22:11:39 INFO - 'USER': 'cltbld', 22:11:39 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:39 INFO - '_': '/tools/buildbot/bin/python'} 22:11:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:39 INFO - Running setup.py (path:/tmp/pip-ySeD97-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:11:39 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)) 22:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:39 INFO - Running setup.py (path:/tmp/pip-3_5Ehq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:11:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:39 INFO - Running setup.py (path:/tmp/pip-IKwYSG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:11:39 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)) 22:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:39 INFO - Running setup.py (path:/tmp/pip-eSAOg9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:11:39 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)) 22:11:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:39 INFO - Running setup.py (path:/tmp/pip-4V3Ble-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:40 INFO - Running setup.py (path:/tmp/pip-oziBx4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:40 INFO - Running setup.py (path:/tmp/pip-ETAoor-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:40 INFO - Running setup.py (path:/tmp/pip-AZ1rs7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:40 INFO - Running setup.py (path:/tmp/pip-ZzzsT_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:40 INFO - Running setup.py (path:/tmp/pip-5MboKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:40 INFO - Running setup.py (path:/tmp/pip-XwKdTP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:40 INFO - Running setup.py (path:/tmp/pip-561bUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:40 INFO - Running setup.py (path:/tmp/pip-EImjDK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:40 INFO - Running setup.py (path:/tmp/pip-DSBDgP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:40 INFO - Running setup.py (path:/tmp/pip-zAlj5O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:40 INFO - Running setup.py (path:/tmp/pip-xQP6Zh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:11:40 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)) 22:11:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:40 INFO - Running setup.py (path:/tmp/pip-qSND0_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:11:40 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)) 22:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:11:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:11:40 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)) 22:11:40 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)) 22:11:40 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)) 22:11:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:42 INFO - Downloading blessings-1.6.tar.gz 22:11:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:11:42 INFO - Installing collected packages: blessings 22:11:42 INFO - Running setup.py install for blessings 22:11:42 INFO - Successfully installed blessings 22:11:42 INFO - Cleaning up... 22:11:42 INFO - Return code: 0 22:11:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:11:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:11:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:11:43 INFO - Reading from file tmpfile_stdout 22:11:43 INFO - Current package versions: 22:11:43 INFO - argparse == 1.2.1 22:11:43 INFO - blessings == 1.6 22:11:43 INFO - blobuploader == 1.2.4 22:11:43 INFO - docopt == 0.6.1 22:11:43 INFO - manifestparser == 1.1 22:11:43 INFO - mozInstall == 1.12 22:11:43 INFO - mozcrash == 0.16 22:11:43 INFO - mozdebug == 0.1 22:11:43 INFO - mozdevice == 0.48 22:11:43 INFO - mozfile == 1.2 22:11:43 INFO - mozhttpd == 0.7 22:11:43 INFO - mozinfo == 0.9 22:11:43 INFO - mozleak == 0.1 22:11:43 INFO - mozlog == 3.1 22:11:43 INFO - moznetwork == 0.27 22:11:43 INFO - mozprocess == 0.22 22:11:43 INFO - mozprofile == 0.28 22:11:43 INFO - mozrunner == 6.11 22:11:43 INFO - mozscreenshot == 0.1 22:11:43 INFO - mozsystemmonitor == 0.0 22:11:43 INFO - moztest == 0.7 22:11:43 INFO - mozversion == 1.4 22:11:43 INFO - psutil == 3.1.1 22:11:43 INFO - requests == 1.2.3 22:11:43 INFO - wsgiref == 0.1.2 22:11:43 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:11:43 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')]} 22:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:43 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')]} 22:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:43 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:43 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 22:11:43 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 22:11:43 INFO - Using env: {'DISPLAY': ':0', 22:11:43 INFO - 'HOME': '/home/cltbld', 22:11:43 INFO - 'LANG': 'en_US.UTF-8', 22:11:43 INFO - 'LANGUAGE': 'en_US:en', 22:11:43 INFO - 'LOGNAME': 'cltbld', 22:11:43 INFO - 'MAIL': '/var/mail/cltbld', 22:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:43 INFO - 'MOZ_NO_REMOTE': '1', 22:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:43 INFO - 'NO_EM_RESTART': '1', 22:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:43 INFO - 'SHELL': '/bin/bash', 22:11:43 INFO - 'SHLVL': '1', 22:11:43 INFO - 'TERM': 'linux', 22:11:43 INFO - 'TMOUT': '86400', 22:11:43 INFO - 'USER': 'cltbld', 22:11:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:43 INFO - '_': '/tools/buildbot/bin/python'} 22:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 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)) 22:11:43 INFO - Cleaning up... 22:11:43 INFO - Return code: 0 22:11:43 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:11:43 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')]} 22:11:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:43 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')]} 22:11:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:43 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:43 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 22:11:43 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 22:11:43 INFO - Using env: {'DISPLAY': ':0', 22:11:43 INFO - 'HOME': '/home/cltbld', 22:11:43 INFO - 'LANG': 'en_US.UTF-8', 22:11:43 INFO - 'LANGUAGE': 'en_US:en', 22:11:43 INFO - 'LOGNAME': 'cltbld', 22:11:43 INFO - 'MAIL': '/var/mail/cltbld', 22:11:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:43 INFO - 'MOZ_NO_REMOTE': '1', 22:11:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:43 INFO - 'NO_EM_RESTART': '1', 22:11:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:43 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:43 INFO - 'SHELL': '/bin/bash', 22:11:43 INFO - 'SHLVL': '1', 22:11:43 INFO - 'TERM': 'linux', 22:11:43 INFO - 'TMOUT': '86400', 22:11:43 INFO - 'USER': 'cltbld', 22:11:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:43 INFO - '_': '/tools/buildbot/bin/python'} 22:11:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:43 INFO - Downloading/unpacking jsonschema 22:11:43 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 22:11:43 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 22:11:43 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 22:11:43 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 22:11:43 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 22:11:43 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 22:11:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:11:45 INFO - Downloading/unpacking functools32 (from jsonschema) 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:45 INFO - Downloading functools32-3.2.3-2.tar.gz 22:11:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:11:45 INFO - warning: no files found matching '*.txt' 22:11:45 INFO - no previously-included directories found matching 'build' 22:11:45 INFO - no previously-included directories found matching 'dist' 22:11:45 INFO - no previously-included directories found matching '.git*' 22:11:45 INFO - Installing collected packages: jsonschema, functools32 22:11:45 INFO - Running setup.py install for functools32 22:11:45 INFO - warning: no files found matching '*.txt' 22:11:45 INFO - no previously-included directories found matching 'build' 22:11:45 INFO - no previously-included directories found matching 'dist' 22:11:45 INFO - no previously-included directories found matching '.git*' 22:11:45 INFO - Successfully installed jsonschema functools32 22:11:45 INFO - Cleaning up... 22:11:45 INFO - Return code: 0 22:11:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:11: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')]} 22:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11: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')]} 22:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:11:45 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 0x7f1381bf0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29c98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a99630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, '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': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', '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 22:11:45 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 22:11:45 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 22:11:45 INFO - Using env: {'DISPLAY': ':0', 22:11:45 INFO - 'HOME': '/home/cltbld', 22:11:45 INFO - 'LANG': 'en_US.UTF-8', 22:11:45 INFO - 'LANGUAGE': 'en_US:en', 22:11:45 INFO - 'LOGNAME': 'cltbld', 22:11:45 INFO - 'MAIL': '/var/mail/cltbld', 22:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:11:45 INFO - 'MOZ_NO_REMOTE': '1', 22:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:11:45 INFO - 'NO_EM_RESTART': '1', 22:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:11:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:11:45 INFO - 'SHELL': '/bin/bash', 22:11:45 INFO - 'SHLVL': '1', 22:11:45 INFO - 'TERM': 'linux', 22:11:45 INFO - 'TMOUT': '86400', 22:11:45 INFO - 'USER': 'cltbld', 22:11:45 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:11:45 INFO - '_': '/tools/buildbot/bin/python'} 22:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:11:46 INFO - Downloading/unpacking flake8 22:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:11:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:11:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:11:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:11:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:11:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11: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 22:11:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:48 INFO - no previously-included directories found matching 'docs/_build' 22:11:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:11:48 INFO - Running setup.py install for pep8 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:11:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:11:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:11:48 INFO - no previously-included directories found matching 'docs/_build' 22:11:48 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:11:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:11:48 INFO - Cleaning up... 22:11:48 INFO - Return code: 0 22:11:48 INFO - Running post-action listener: _resource_record_post_action 22:11:48 INFO - Running post-action listener: _start_resource_monitoring 22:11:48 INFO - Starting resource monitoring. 22:11:48 INFO - ##### 22:11:48 INFO - ##### Running install step. 22:11:48 INFO - ##### 22:11:48 INFO - Running pre-action listener: _resource_record_pre_action 22:11:48 INFO - Running main action method: install 22:11:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:11:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:11:48 INFO - Reading from file tmpfile_stdout 22:11:48 INFO - Detecting whether we're running mozinstall >=1.0... 22:11:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:11:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:11:49 INFO - Reading from file tmpfile_stdout 22:11:49 INFO - Output received: 22:11:49 INFO - Usage: mozinstall [options] installer 22:11:49 INFO - Options: 22:11:49 INFO - -h, --help show this help message and exit 22:11:49 INFO - -d DEST, --destination=DEST 22:11:49 INFO - Directory to install application into. [default: 22:11:49 INFO - "/builds/slave/test-pgo"] 22:11:49 INFO - --app=APP Application being installed. [default: firefox] 22:11:49 INFO - mkdir: /builds/slave/test-pgo/build/application 22:11:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:11:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:12:05 INFO - Reading from file tmpfile_stdout 22:12:05 INFO - Output received: 22:12:05 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:12:05 INFO - Running post-action listener: _resource_record_post_action 22:12:05 INFO - ##### 22:12:05 INFO - ##### Running run-tests step. 22:12:05 INFO - ##### 22:12:05 INFO - Running pre-action listener: _resource_record_pre_action 22:12:05 INFO - Running main action method: run_tests 22:12:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:12:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:12:05 INFO - Python 2.7.3 22:12:05 INFO - Return code: 0 22:12:05 INFO - grabbing minidump binary from tooltool 22:12:05 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')]} 22:12:05 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 0x2b2a840>, '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 0x2a976b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a97b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:12:05 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 22:12:05 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 22:12:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:12:05 INFO - Return code: 0 22:12:05 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:12:05 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:12:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:12:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:12:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:12:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:12:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:12:06 INFO - Return code: 0 22:12:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 22:12:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 22:12:06 INFO - Using env: {'DISPLAY': ':0', 22:12:06 INFO - 'HOME': '/home/cltbld', 22:12:06 INFO - 'LANG': 'en_US.UTF-8', 22:12:06 INFO - 'LANGUAGE': 'en_US:en', 22:12:06 INFO - 'LOGNAME': 'cltbld', 22:12:06 INFO - 'MAIL': '/var/mail/cltbld', 22:12:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:12:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:12:06 INFO - 'MOZ_NO_REMOTE': '1', 22:12:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:12:06 INFO - 'NO_EM_RESTART': '1', 22:12:06 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:12:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:12:06 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:12:06 INFO - 'SHELL': '/bin/bash', 22:12:06 INFO - 'SHLVL': '1', 22:12:06 INFO - 'TERM': 'linux', 22:12:06 INFO - 'TMOUT': '86400', 22:12:06 INFO - 'USER': 'cltbld', 22:12:06 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949', 22:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:12:06 INFO - '_': '/tools/buildbot/bin/python'} 22:12:06 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 22:12:06 INFO - mozversion application_buildid: 20160205193440 22:12:06 INFO - mozversion application_changeset: 0885625045f0d07ab8ce6d46d8b354939aa3b617 22:12:06 INFO - mozversion application_display_name: Nightly 22:12:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:12:06 INFO - mozversion application_name: Firefox 22:12:06 INFO - mozversion application_remotingname: firefox 22:12:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:12:06 INFO - mozversion application_vendor: Mozilla 22:12:06 INFO - mozversion application_version: 47.0a1 22:12:06 INFO - mozversion platform_buildid: 20160205193440 22:12:06 INFO - mozversion platform_changeset: 0885625045f0d07ab8ce6d46d8b354939aa3b617 22:12:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:12:06 INFO - mozversion platform_version: 47.0a1 22:12:06 INFO - using testdate: 1454739126 22:12:06 INFO - actual date: 1454739126 22:12:06 INFO - starting webserver on 'localhost:56995' 22:12:06 INFO - SUITE-START | Running 2 tests 22:12:06 INFO - TEST-START | dromaeo_css 22:12:06 INFO - operating with platform_type : linux_ 22:12:06 INFO - Initialising browser for dromaeo_css test... 22:12:06 INFO - TEST-INFO | started process 12147 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptBOm1m/profile http://localhost:56995/getInfo.html) 22:12:10 INFO - PROCESS | 12147 | 22:12:10 INFO - PROCESS | 12147 | (process:12226): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:12:11 INFO - PROCESS | 12147 | __metrics Screen width/height:1600/1200 22:12:11 INFO - PROCESS | 12147 | colorDepth:24 22:12:11 INFO - PROCESS | 12147 | Browser inner width/height: 1024/697 22:12:11 INFO - PROCESS | 12147 | __metrics 22:12:12 INFO - TEST-INFO | 12147: exit 0 22:12:12 INFO - Browser initialized. 22:12:12 INFO - Running cycle 1/1 for dromaeo_css test... 22:12:12 INFO - TEST-INFO | started process 12275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptBOm1m/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:12:13 INFO - PROCESS | 12275 | 22:12:13 INFO - PROCESS | 12275 | (process:12332): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:12:24 INFO - PROCESS | 12275 | RSS: Main: 154513408 22:12:24 INFO - PROCESS | 12275 | 22:13:13 INFO - PROCESS | 12275 | 1454739193961 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] 22:15:23 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56995/tests/dromaeo/cssquery-ext.html) 22:15:23 INFO - PROCESS | 12275 | RSS: Main: 162086912 22:15:23 INFO - PROCESS | 12275 | 22:18:25 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-ext.html (next: http://localhost:56995/tests/dromaeo/cssquery-jquery.html) 22:18:26 INFO - PROCESS | 12275 | RSS: Main: 158138368 22:18:26 INFO - PROCESS | 12275 | 22:21:28 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56995/tests/dromaeo/cssquery-mootools.html) 22:21:28 INFO - PROCESS | 12275 | RSS: Main: 157536256 22:21:28 INFO - PROCESS | 12275 | 22:24:30 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56995/tests/dromaeo/cssquery-prototype.html) 22:24:31 INFO - PROCESS | 12275 | RSS: Main: 155381760 22:24:31 INFO - PROCESS | 12275 | 22:27:33 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56995/tests/dromaeo/cssquery-yui.html) 22:27:34 INFO - PROCESS | 12275 | RSS: Main: 156254208 22:27:34 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | Cycle 1(1): loaded http://localhost:56995/tests/dromaeo/cssquery-yui.html (next: http://localhost:56995/tests/dromaeo/cssquery-dojo.html) 22:30:36 INFO - PROCESS | 12275 | RSS: Main: 159801344 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | __start_tp_report 22:30:36 INFO - PROCESS | 12275 | _x_x_mozilla_page_load 22:30:36 INFO - PROCESS | 12275 | _x_x_mozilla_page_load_details 22:30:36 INFO - PROCESS | 12275 | |i|pagename|runs| 22:30:36 INFO - PROCESS | 12275 | |0;dojo.html;3250.9837450812747;3328.783629064109;3341.398548261312;3356.462965925451;3373.932521349573;5401.054815407308;5508.421615730351;5537.944620553793;5561.499465048145;5583.972080139599;5535.225068490415;5545.417731138233;5546.86132846679;5574;5591.664500129995;5040.495950404967;5078.771455284503;5086.796528138889;5090.236464530331;5137.280780690707;5079.873003174932;5142.0487209866105;5148.330717006803;5202.089634313998;5238.423773384925;4905.779239934193;5041.269015992679;5113.335266415379;5118.6416950813455;5125.026245013435;5026.798928042874;5038.193888977746;5049.671771334888;5078.898422031576;5111.207762796773;4928.950710492885;5010.649254552182;5020.523050310215;5027.748612569357;5029.823956161516;5347.6256662033675;5382.811601593965;5396.298481197419;5414.3232095988005;5417.295751552273;5950.196723442366;5982.192404025488;5992.161097446361;5993.370696076936;6017.548683848685;5855.238818953551;5970.641761494324;5994;6027.9095813562835;6068.180795592582;5540.418256083134;5547.417521160261;5558.221848941152;5586.413426590231;5589.217509548666;5943.227380440515;6080.209572755602;6081.543884208702;6083.148359229712;6086.178365920544;5859.121131830259;5901.380355062656;5928.555358348141;5933.881322373529;5968.612040217372;5893.764249429974;5899.292084949833;5899.941000590025;5904.970475147683;5909.995300798874;5863.912041319383;5894.2926848778425;5914.319853216935;5992.940070599326;6077.270727512727;5935;5949.940500595025;5952.7023648817385;5964.880702385928;5984.581079324493;4515.480719717209;4522.321651752198;4523.683342166082;4554.43069616298;4557.293619488984;3972.920541589152;4052.8328119569114;4068.3287257602756;4081.6122468365456;4127.504699436026;5532;5546.86132846674;5563.693996830213;5579.637323573955;5604.719764011865;5906.202662640574;5925.40745925404;5954.493868021266;5970.76116955317;6013.338532761392;5488.4785945335125;5499.340079190442;5508.7521061552325;5548.805791797267;5616.887662246814;5027.673201241908;5071.949280507221;5072.4673909239;5086.364204474441;5118.61610379223;6131.877362452726;6164.321924588292;6191.9690401548605;6195.659238741822;6246.031865060922;5915.438033386821;5946.613470124428;5958.6424814511265;5960.225170727777;5967.194428752063;6116.3883611638485;6177.876442471035;6180.351063138306;6184.288806787277;6203.100550420074;5897.439743224387;5905.261842269716;5916.467517923407;5916.73374698131;5925.822225333247;5990.940090599212;6011.6693581853415;6014.398560144125;6015.48868346178;6032.547558933185;5694.686792226302;5856.824295271149;5874.441928016831;5878.735456904535;5937.2578427696535;5860.09168578871;5871.647701137946;5875.20684707559;5876.823695289148;5879.118132280192;5699.8860022800145;5756.539476841759;5811.82564523065;5816.098504731774;5819.912701309569;5741.483266506035;5859.736311866061;5896.8820623586425;5920.615160014585;5972.432618901197;5691.402402747652;5721.742521586455;5723.112917497794;5726.513246373938;5730.054541000688 22:30:36 INFO - PROCESS | 12275 | |1;ext.html;515.556621305677;551.3521612105775;556.1685280505643;558.6340946679925;571.2202843119138;35891.64108358919;36884.127166647515;37103.25793484132;37247.627523724754;37273.81363093187;37402.8129859351;38116.618833811655;38292.425613615815;38359.61640383596;38386.23227535448;8224.835503289945;8493.532855692934;8510.276626486726;8516.87224691627;8530.488170709747;8318.875216871751;8435.746927592152;8478.279346255576;8479.618417171243;8485.44844585103;8553.529555874455;8591.656333746643;8591.914080859175;8597.140285971416;8617.61220745068;8477.406581539295;8515.063343032261;8523.914760852436;8564.87152692707;8605.096464871162;8464.153584641548;8545.27365173961;8585.61364738582;8593.398462107654;8606.655733770642;30985.225369365722;36807;37443.81278093619;37466.06334841623;37607.623923760686;2841.5169421198448;3215.4533729265845;3253.96746032539;4015.99600099975;4032.959670403288;26687.866560667266;26818.46363072747;26903.596446053325;27029.864850675818;27272.590911136347;3740.513733214692;3765.171662234304;3765.35988881888;3775.6979441644603;3804.2201348723447;189762;190382;190607;191931;233984.9999999983;54464.45535544594;55798.442015580134;55831.441685583435;55913.7204313984;55997.72001139968;55431;62656.686716567034;63943.36056639467;63999.68000159969;64215;14770;14906.403743850124;14959.775603365959;14962.177080260473;14983;12109.878901211052;12217.389130543437;12264.693382665504;12271.141020128684;12287;18886.43340699781;19135.330263440712;19767.209311627375;19828.405147845588;19841.38874739056;7705.267999540035;7851.214878512217;7902;7964.4823086500355;8080.595970201584;1013.7935856330943;1016.8118898003893;1024.9692509224735;1071.3571856885962;1084.2301965604508;30228.69771302259;30294.697053029628;30347.848260758554;30601.234969125504;30668.539971900438;1081.6917178604217;1102.7518808268235;1158.3571118029406;1164.6797130788932;1195.235049568277;15815.683686326209;16021;16104.838951610334;16260.67478650444;16387.59031024234;317890;318313;319266;319504;320395;49369.259461108115;49918.750406248466;50098.24852627214;50153.24770128451;50265.497345026815;1346.0846624295573;1354.7553609106135;1360.2246719370062;1370.8286464191976;1373.5192682561024;28755.71244287614;30003.849980749957;30036;30246.395072098876;31494.37011259716;47558.52441475541;47660.285095724284;47708;47766.761166193945;47781.28328075012;247073;248399;248740;251037;251148;29007.419851602426;31637.209069772518;31950.840245798623;32018;32202;38659.806700966314;40887.795561022;41889;42353.36469952892;42437.15125697407;35031.29937401289;35368.646313536534;35549.466757999166;35727.64272357243;35993.64006359903;35764.64235357613;36008.81995590005;36312;38240;39659.80170099131;36920.26159476849;36955;36975.630243698295;37412;37498.8125059373;28167.57748633813;32005.199870003435;34845.825770870986;35688.322250157325;36126;25838.354041149123;25843.353916152246;25873.353166170997;26150;26386.20841374762 22:30:36 INFO - PROCESS | 12275 | |2;jquery.html;374.36358191075175;376.6873494999151;378.21897781082066;378.9981050094749;382.8334674416627;16376;17146.82853171468;17177.3129074837;17460;17950.10249487527;11240.437978101083;12528.686782830433;16844.57888552787;16997.745033824503;17058.744118838196;4909.288153217782;5422.40353561108;5648.435156484339;5702.315722113352;5702.515286200678;5513.338399392059;5527.309086364205;5552.694601796919;5558.249636299089;5570.387257401682;5597.132444471114;6178.104174894637;6251.218597675291;6272.968635156841;6299.622022678654;6201.007838745802;6233.34549872266;6240.781572644935;6245.687715614224;6248.437640612344;5383.730813459311;5458.645188062763;5466.508014278734;5490.478404551562;5509.035918714249;12574.68563285916;12963.546275880393;13020;13056.738865222738;16968.3212671493;1935.5741736818018;1981.4650044487908;2063.3603582889355;2280.4754906371627;2729.1539622717023;9392.953035234848;9830.508474576243;13822.792658110136;13874.514391996232;14894.255287235595;1757.2707326459504;1774.547490389955;1835.8990255535941;1838.2646941223484;1846.3630047633544;66277.33722662808;66456;68097.3190268096;69358;71985.28014719838;15138.848611513744;15739;15786.447474338343;15822.52532424029;15930.60173495672;24320.635190472156;24339.634905476432;24601.876990614932;24749.5050098997;24973.750262497506;7371.926280737124;7508.361789247866;7879.527228366316;7898.328642065489;7921.881171782428;7611.3530349919765;7627.466077374531;7636.198199189116;7639.809004774814;7652.579108149105;4404.933925991113;4469.932951005738;4538.72767633943;4565.246734288871;4585.541445855388;1844.7509586205958;1954.3192854145423;1958.1384190955935;1966.6853303471662;1991.541945352577;934.4019827310527;960.9519524023771;987.5062468765617;1074.7689246811817;1085.159001773616;17436.12819359027;17522.29910803579;17709.911450442924;17805.287788488575;17913.820861791475;985.6205360936091;1004.4726518577659;1018.8471729240525;1026.3123707116101;1030.0729343590829;10114.544845481823;10235.078842904175;10315;10378.792424151474;10387.532561034772;383504;391310;567053;573751;579788;69053;69593;77411.61294193605;78386;79502;505.815377387251;516.5118962580401;518.289942778396;518.3857129301714;520.7734635433599;10367.688969330931;10883.945580272048;10976.451177441255;11008.568886044763;15052.623684407978;30714;31021.534676980315;31521.8423907879;31751.364972699954;31757.8412107938;41495.377569335884;41730.58269417267;41806.1638767229;41883;41953;7460.975658380008;7750.341220996278;7971.880421793562;7977.2022797719765;8076.676932922853;9438;11932.403379831147;12024.579139730067;12042.698932526757;12046.216995895238;10369.429681367597;10509.9474502627;10689;10910;11004.284721493077;10236.641717539851;10476.68569942903;10645.148388129086;10689.51897164645;10750.247482676137;9779.559919803769;10702.090322322378;10771.6229931952;10832.729181770204;11088.279261847954;7673.232676732506;7794.727184548514;7888.6450109744055;7889.763307100796;7897.210278972057;9126.315526335684;10184.643537476153;10205.948970255102;10257.692269231935;10407.895921040996 22:30:36 INFO - PROCESS | 12275 | |3;mootools.html;1491.2916364726752;1492.4477943161028;1696.6861130690822;1817.182267979408;1853.6570734414142;7212.386947109502;7917.524948503094;8016.879746803796;8242.587870606469;8280.378971577133;7974.7208847690345;8022.197780221975;8093.2311430414165;8101.959490202556;8108.148644392342;2326.336993956723;2342.4495243617735;2363.1847012780563;2364.243442098529;2369.6919400477914;2336.544373847092;2365.4559451326118;2369.1589485732575;2373.2405630198346;2373.5134297469062;2022.201230513946;2290.278562252885;2330.4057465346395;2338.018032426385;2353.105819788478;2287.5196208796006;2290.702208712865;2295.908163673451;2313.34069790109;2322.918697845576;2283.155232563962;2294.1167650454527;2305.354500739779;2309.3880121767743;2323.7560056194193;8047.396445266629;8086.393520485987;8086.919130808734;8105.1084380718075;8109.95945020277;4936.80252789888;5020.573251273646;5022.4977502249485;5057.266696329012;5068.467810879878;3112.766542509321;3119.703628155344;3201.775875688703;3219.5009773484912;3257.0228931320744;990.7275499237695;996.2378780233128;1002.1982414068789;1005.8491226316111;1021.6117875207374;11226.607068752635;11287.322760634388;11300.378479183642;11356.829647555292;11386.202965792398;4551.40831691878;4564.1556312082375;4619.214733495314;4630.791614377294;4660.39414876064;9609.663661771805;9646;9669.564869580885;9676.467794271382;9680.56437460316;4969.503049695001;4978.203487442064;4979.053979743837;4982.6512144149565;5018.096742586369;4478.305862591304;4481.596656300949;4488.192125417391;4534.229181039232;4547.386102876136;3842.9039274018373;3888.786116763605;3913.354296541039;3923.6664883484655;3941.7437866538585;1161.9477123529462;1243.7263801963554;1254.3101294288106;1258.8867001969866;1276.9744605107846;1058.142904247562;1058.227493929436;1105.165599972016;1242.7763002659428;1351.9256440895845;7400.777976660709;7487.925120748831;7509.586972716553;7569.167391586921;7582.241775822374;1149.8850114988434;1158.7566611011782;1167.480471190312;1168.6669299249672;1169.4328250798355;5789.160571717078;5843.824685259449;5864.266966629171;5876.177335173079;5900.055991041413;9424.811503769886;9837.80324393508;9924.751881203028;9978.301518893608;10043.096121348968;9850.359726617748;9854.359466634645;9872.111509963994;9886.505674716236;9946.751331216778;7476.813079672943;7720.8455830884195;7730.845383092306;7763.650635721406;7792.454528183086;7308.451866110169;7311.524750891175;7358.337749602561;7362.116546014298;7387.852242955219;8551.871721924052;8849.778755530906;8932.50871202064;8981.46111233302;9013.954930225307;8758.386912916034;8818.91181088181;8848.203661670223;8885.600147993486;8942.552872356226;7030.578165310098;7099.183593886562;7116.252793456612;7137.286271372821;7150.462650530161;7625.961870190614;7688.923110768821;7701.88447173304;7726.1501234863;7727.845443091219;6538.640374779243;7253.56478611285;7280.0535930328715;7346.412287017132;7463.962680186564;7206.9030573236005;7259.9274007259255;7318.670659820427;7357.448191385561;7374.410047196318;7295.379892709179;7367.815804604714;7373.668184931584;7383.2985866342615;7410.481266311306;6496.317886621837;6571.474282057328;6623.933760662332;6628.436582890508;6641.867162656817;6806.727730890709;6843.589384636938;6843.7604683835825;6870.828229294308;6879.552829066095 22:30:36 INFO - PROCESS | 12275 | |4;prototype.html;348.2634228606497;356.9179088809574;358.98564057437704;360.3225935241745;364.531576923653;6149.692515374225;6269.623822570649;6277.843053923654;6307.936920630798;6310.116583678288;6310.4320611144985;6311.968440157804;6314.905276420845;6319.178506794122;6347.36526347365;4818.951810481885;4820.758962051901;4832.3717916670785;4838.371011768465;4840.6369522285795;4834.2265237562;4836.927446088312;4841.104395686792;4851.442084160331;4852.587530059932;4711.9764401177945;4812.68717533361;4824.5416685415;4838.250071238964;4841.56425921667;4789.449213340476;4805.903881922342;4814.590759785422;4817.879553011167;4827.106985207713;4211.684123690705;4216.325387937946;4235.724677895958;4238.96145444365;4254.298040823261;5931.703414829241;6074.2103526541705;6083.634981901056;6094.055421409645;6096.451319381233;5527.613067085305;5539.113741801292;5545.195946587723;5552.278203833516;5562.415946325658;6677.332266773333;6687.531872768908;6706.396424321834;6711.295313992009;6726.764563240263;4582.931256031162;4584.243599806028;4588.38056862326;4605.516420775803;4605.930911036304;6831.077804496379;7012.9298707013295;7022.92977070233;7027.82430439238;7067.116610423697;4650.883727906829;4680.4149481314835;4681.321208424827;4693.272542755878;4705.976470117627;4762.285657151455;4768.976155119202;4774.570288673966;4775.5224477551965;4775.71345719258;5438.238646589481;5476.972615136899;5543.1408131739645;5551.278333816578;5563.332400112013;6727.125473688389;6777.695003724844;6792.864142717118;6804.149481314836;6821.55659882116;1602.110828490199;1633.207894171326;1654.6525229701656;1656.6521030583472;1676.740105283683;1096.5010920031366;1097.1332647208776;1103.7185517692938;1116.6538373104363;1123.702218911989;6268.749250029948;6296.118543403927;6348.523860710465;6359.682015899279;6365.681715914186;6772.288909664513;6818.454523638097;6826.078479405316;6838.076859623887;6838.452923766087;6030.758769649253;6130.049842274455;6140.048292514667;6180.042093475518;6193.535484838565;3692.8707495237536;3695.316366472211;3707.888763337104;3722.2927643748144;3723.404255319136;7126.821829454201;7131.750388736369;7155.856882862314;7162.283771622796;7167.139943206745;6917.342852429011;6924.4114250289285;6929.618870962146;6977.232504424509;6980.371766541036;7314.232005639331;7314.354270289249;7315.926840731631;7319;7319.560826350436;6956.5478243913985;6960.756373526902;6978.581285122909;6995.440364770704;7030.50786444944;6776.7628133015105;6874.793756187322;6879.828004299932;6882.139732533434;6918.723251070102;7311.488195826241;7317.853642927218;7324.121105467378;7333.559986400833;7334.413246940126;4624.3294722265755;4702;4709.5055019223855;4712.128256272601;4724.1260366830875;6911.896321555281;7009.614471204132;7011.6844741985715;7014.158301003912;7028.402585780266;6758.594484330956;6777.2883847195335;6777.796666100025;6803.625800580818;6831.726730930906;6752.69612867432;6789.219239787488;6791.252962174058;6793.320667933167;6810.216825065181;6555.737770489127;6623.735050597922;6661.367170118831;6671.199456065303;6676.465882729273;6761.797146085625;6772.796816095525;6808.114945057111;6821.249662537216;6822.351876571916;6580.159476994777;6665.600063996176;6677.6661166940485;6685.933140668531;6686.632235226914 22:30:36 INFO - PROCESS | 12275 | |5;yui.html;764.121260550367;774.1097737601758;777.8211011467358;783.721778768537;796.5618909599723;11659;11723.179377443583;11793.70515737107;11795.882041179586;11940.044796416276;12760.936195319033;14132.152070875729;14464.638384040405;14489.63775905603;14506.637334066627;683.4361651637395;803.4295650088444;815.3273549321804;821.1255013410728;823.3618945317397;825.5376988886243;828.1635548096436;828.7348048624442;829.1873963515728;829.340674164041;862.3790870573177;863.0290922711949;866.3762091294258;866.9942866275122;868.3183700794877;853.7950891785989;854;857.618359829876;858.845407826591;868.7089824908631;637.1271358239196;639.2488825629866;640.7405000974566;643;643.1960049937578;12708.872911270953;12750.936245318806;12811.679708007281;12817.35913204336;12832.871671283261;12961.287129207889;12979.935100324532;13002.284874332003;13310.134841235289;13393.799093013613;10566.471676416148;10609.68170954865;10650.627228046982;10914.290571112932;10990.395528245943;3450.9827450862585;3478.087748550367;3493.9650603494147;3510;3525.2068284636007;49054.509454905354;49624;49712.75143624295;49809.25286120711;49842.7507862462;9795.951020244996;10176.949115254376;10520.473976301308;10529.568619632635;10753.569857205624;18019.639607207784;18090.728639070163;18139.18373673188;18226.544336391697;18245.7263141053;6933.965330173317;7139.286071392923;7146.32109949554;7285.672144753499;7369.852602948018;3901.4733011043713;4088.7955602220363;4209.74741515504;4227.492700875853;4234;3178.3484385700876;3193.8243396612943;3197.872085116616;3206.5190221466964;3219.323941972212;585.5696063393402;595.6524333247179;596.5227817745786;608.0210860514568;614.5390956782413;444.97997590108525;555.3197333266716;562.9127485239794;577.0853197681721;581.7614777941023;8573.099824518336;8704.338184615071;8807.955960220286;8840.860535598895;8941.821163576693;581.7789240088824;586.7037146241121;595.0508938243495;619.9008158694587;730.455810421229;3798.4682144499793;3994.8801535953967;4057.2899742544937;4154.252234597801;4161.334186530141;53748.19377709337;55223.44776552183;55511.444885551435;55577;55590.44409555852;44089;44864.10271794546;47286.52713472821;47684;48182.27726584104;43347.9163020927;43492;45371.54628453673;46196.538034619894;48579.271310930366;8665.956670216608;8691.652333906826;8715.564221788758;8775.341849361452;8887.289016878764;32200.516992245604;32438.83780581082;33001;33180.1704957378;34126.146846329044;38287.23425531529;38766.6123338763;39556.60443395529;39932.2013559733;40375.798121009204;10577.36535807854;10616.52225649863;10709.250352475563;10785.946070269598;10871.130309575374;11868.169228153947;12160.635180944586;12223.083268755057;12342.13605047638;12979.286139262054;11637.88362116368;11898.345590992578;11898.940505297418;12187.451564679788;12345.814812777995;11626;11727.47226374798;11898.643040708792;12177.512899483922;12339.383030848601;10709.303895246783;10773.946130269298;10865.782684346426;11132.499037543168;11185.552577897119;9241.537923103953;9359.719208423758;9490.572924218288;9843.901560984299;9862.506874656381;9259.259259259377;9345.626174953197;9772;10018.39889606626;10239.129673977795 22:30:36 INFO - PROCESS | 12275 | __end_tp_report 22:30:36 INFO - PROCESS | 12275 | __start_cc_report 22:30:36 INFO - PROCESS | 12275 | _x_x_mozilla_cycle_collect,325 22:30:36 INFO - PROCESS | 12275 | __end_cc_report 22:30:36 INFO - PROCESS | 12275 | __startTimestamp1454740236812__endTimestamp 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | ------- Summary: start ------- 22:30:36 INFO - PROCESS | 12275 | Number of tests: 6 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | [#0] dojo.html Cycles:165 Average:5531.61 Median:5741.48 stddev:621.83 (10.8%) stddev-sans-first:597.44 22:30:36 INFO - PROCESS | 12275 | Values: 3251.0 3328.8 3341.4 3356.5 3373.9 5401.1 5508.4 5537.9 5561.5 5584.0 5535.2 5545.4 5546.9 5574.0 5591.7 5040.5 5078.8 5086.8 5090.2 5137.3 5079.9 5142.0 5148.3 5202.1 5238.4 4905.8 5041.3 5113.3 5118.6 5125.0 5026.8 5038.2 5049.7 5078.9 5111.2 4929.0 5010.6 5020.5 5027.7 5029.8 5347.6 5382.8 5396.3 5414.3 5417.3 5950.2 5982.2 5992.2 5993.4 6017.5 5855.2 5970.6 5994.0 6027.9 6068.2 5540.4 5547.4 5558.2 5586.4 5589.2 5943.2 6080.2 6081.5 6083.1 6086.2 5859.1 5901.4 5928.6 5933.9 5968.6 5893.8 5899.3 5899.9 5905.0 5910.0 5863.9 5894.3 5914.3 5992.9 6077.3 5935.0 5949.9 5952.7 5964.9 5984.6 4515.5 4522.3 4523.7 4554.4 4557.3 3972.9 4052.8 4068.3 4081.6 4127.5 5532.0 5546.9 5563.7 5579.6 5604.7 5906.2 5925.4 5954.5 5970.8 6013.3 5488.5 5499.3 5508.8 5548.8 5616.9 5027.7 5071.9 5072.5 5086.4 5118.6 6131.9 6164.3 6192.0 6195.7 6246.0 5915.4 5946.6 5958.6 5960.2 5967.2 6116.4 6177.9 6180.4 6184.3 6203.1 5897.4 5905.3 5916.5 5916.7 5925.8 5990.9 6011.7 6014.4 6015.5 6032.5 5694.7 5856.8 5874.4 5878.7 5937.3 5860.1 5871.6 5875.2 5876.8 5879.1 5699.9 5756.5 5811.8 5816.1 5819.9 5741.5 5859.7 5896.9 5920.6 5972.4 5691.4 5721.7 5723.1 5726.5 5730.1 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | [#1] ext.html Cycles:180 Average:42999.33 Median:36067.41 stddev:68055.97 (188.7%) stddev-sans-first:68172.13 22:30:36 INFO - PROCESS | 12275 | Values: 515.6 551.4 556.2 558.6 571.2 35891.6 36884.1 37103.3 37247.6 37273.8 37402.8 38116.6 38292.4 38359.6 38386.2 8224.8 8493.5 8510.3 8516.9 8530.5 8318.9 8435.7 8478.3 8479.6 8485.4 8553.5 8591.7 8591.9 8597.1 8617.6 8477.4 8515.1 8523.9 8564.9 8605.1 8464.2 8545.3 8585.6 8593.4 8606.7 30985.2 36807.0 37443.8 37466.1 37607.6 2841.5 3215.5 3254.0 4016.0 4033.0 26687.9 26818.5 26903.6 27029.9 27272.6 3740.5 3765.2 3765.4 3775.7 3804.2 189762.0 190382.0 190607.0 191931.0 233985.0 54464.5 55798.4 55831.4 55913.7 55997.7 55431.0 62656.7 63943.4 63999.7 64215.0 14770.0 14906.4 14959.8 14962.2 14983.0 12109.9 12217.4 12264.7 12271.1 12287.0 18886.4 19135.3 19767.2 19828.4 19841.4 7705.3 7851.2 7902.0 7964.5 8080.6 1013.8 1016.8 1025.0 1071.4 1084.2 30228.7 30294.7 30347.8 30601.2 30668.5 1081.7 1102.8 1158.4 1164.7 1195.2 15815.7 16021.0 16104.8 16260.7 16387.6 317890.0 318313.0 319266.0 319504.0 320395.0 49369.3 49918.8 50098.2 50153.2 50265.5 1346.1 1354.8 1360.2 1370.8 1373.5 28755.7 30003.8 30036.0 30246.4 31494.4 47558.5 47660.3 47708.0 47766.8 47781.3 247073.0 248399.0 248740.0 251037.0 251148.0 29007.4 31637.2 31950.8 32018.0 32202.0 38659.8 40887.8 41889.0 42353.4 42437.2 35031.3 35368.6 35549.5 35727.6 35993.6 35764.6 36008.8 36312.0 38240.0 39659.8 36920.3 36955.0 36975.6 37412.0 37498.8 28167.6 32005.2 34845.8 35688.3 36126.0 25838.4 25843.4 25873.4 26150.0 26386.2 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | [#2] jquery.html Cycles:180 Average:27228.80 Median:16066.10 stddev:83072.49 (517.1%) stddev-sans-first:83281.05 22:30:36 INFO - PROCESS | 12275 | Values: 374.4 376.7 378.2 379.0 382.8 16376.0 17146.8 17177.3 17460.0 17950.1 11240.4 12528.7 16844.6 16997.7 17058.7 4909.3 5422.4 5648.4 5702.3 5702.5 5513.3 5527.3 5552.7 5558.2 5570.4 5597.1 6178.1 6251.2 6273.0 6299.6 6201.0 6233.3 6240.8 6245.7 6248.4 5383.7 5458.6 5466.5 5490.5 5509.0 12574.7 12963.5 13020.0 13056.7 16968.3 1935.6 1981.5 2063.4 2280.5 2729.2 9393.0 9830.5 13822.8 13874.5 14894.3 1757.3 1774.5 1835.9 1838.3 1846.4 66277.3 66456.0 68097.3 69358.0 71985.3 15138.8 15739.0 15786.4 15822.5 15930.6 24320.6 24339.6 24601.9 24749.5 24973.8 7371.9 7508.4 7879.5 7898.3 7921.9 7611.4 7627.5 7636.2 7639.8 7652.6 4404.9 4469.9 4538.7 4565.2 4585.5 1844.8 1954.3 1958.1 1966.7 1991.5 934.4 961.0 987.5 1074.8 1085.2 17436.1 17522.3 17709.9 17805.3 17913.8 985.6 1004.5 1018.8 1026.3 1030.1 10114.5 10235.1 10315.0 10378.8 10387.5 383504.0 391310.0 567053.0 573751.0 579788.0 69053.0 69593.0 77411.6 78386.0 79502.0 505.8 516.5 518.3 518.4 520.8 10367.7 10883.9 10976.5 11008.6 15052.6 30714.0 31021.5 31521.8 31751.4 31757.8 41495.4 41730.6 41806.2 41883.0 41953.0 7461.0 7750.3 7971.9 7977.2 8076.7 9438.0 11932.4 12024.6 12042.7 12046.2 10369.4 10509.9 10689.0 10910.0 11004.3 10236.6 10476.7 10645.1 10689.5 10750.2 9779.6 10702.1 10771.6 10832.7 11088.3 7673.2 7794.7 7888.6 7889.8 7897.2 9126.3 10184.6 10205.9 10257.7 10407.9 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | [#3] mootools.html Cycles:180 Average:5694.85 Median:6555.06 stddev:2960.47 (45.2%) stddev-sans-first:2951.91 22:30:36 INFO - PROCESS | 12275 | Values: 1491.3 1492.4 1696.7 1817.2 1853.7 7212.4 7917.5 8016.9 8242.6 8280.4 7974.7 8022.2 8093.2 8102.0 8108.1 2326.3 2342.4 2363.2 2364.2 2369.7 2336.5 2365.5 2369.2 2373.2 2373.5 2022.2 2290.3 2330.4 2338.0 2353.1 2287.5 2290.7 2295.9 2313.3 2322.9 2283.2 2294.1 2305.4 2309.4 2323.8 8047.4 8086.4 8086.9 8105.1 8110.0 4936.8 5020.6 5022.5 5057.3 5068.5 3112.8 3119.7 3201.8 3219.5 3257.0 990.7 996.2 1002.2 1005.8 1021.6 11226.6 11287.3 11300.4 11356.8 11386.2 4551.4 4564.2 4619.2 4630.8 4660.4 9609.7 9646.0 9669.6 9676.5 9680.6 4969.5 4978.2 4979.1 4982.7 5018.1 4478.3 4481.6 4488.2 4534.2 4547.4 3842.9 3888.8 3913.4 3923.7 3941.7 1161.9 1243.7 1254.3 1258.9 1277.0 1058.1 1058.2 1105.2 1242.8 1351.9 7400.8 7487.9 7509.6 7569.2 7582.2 1149.9 1158.8 1167.5 1168.7 1169.4 5789.2 5843.8 5864.3 5876.2 5900.1 9424.8 9837.8 9924.8 9978.3 10043.1 9850.4 9854.4 9872.1 9886.5 9946.8 7476.8 7720.8 7730.8 7763.7 7792.5 7308.5 7311.5 7358.3 7362.1 7387.9 8551.9 8849.8 8932.5 8981.5 9014.0 8758.4 8818.9 8848.2 8885.6 8942.6 7030.6 7099.2 7116.3 7137.3 7150.5 7626.0 7688.9 7701.9 7726.2 7727.8 6538.6 7253.6 7280.1 7346.4 7464.0 7206.9 7259.9 7318.7 7357.4 7374.4 7295.4 7367.8 7373.7 7383.3 7410.5 6496.3 6571.5 6623.9 6628.4 6641.9 6806.7 6843.6 6843.8 6870.8 6879.6 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | [#4] prototype.html Cycles:180 Average:5605.40 Median:6309.03 stddev:1709.87 (27.1%) stddev-sans-first:1668.52 22:30:36 INFO - PROCESS | 12275 | Values: 348.3 356.9 359.0 360.3 364.5 6149.7 6269.6 6277.8 6307.9 6310.1 6310.4 6312.0 6314.9 6319.2 6347.4 4819.0 4820.8 4832.4 4838.4 4840.6 4834.2 4836.9 4841.1 4851.4 4852.6 4712.0 4812.7 4824.5 4838.3 4841.6 4789.4 4805.9 4814.6 4817.9 4827.1 4211.7 4216.3 4235.7 4239.0 4254.3 5931.7 6074.2 6083.6 6094.1 6096.5 5527.6 5539.1 5545.2 5552.3 5562.4 6677.3 6687.5 6706.4 6711.3 6726.8 4582.9 4584.2 4588.4 4605.5 4605.9 6831.1 7012.9 7022.9 7027.8 7067.1 4650.9 4680.4 4681.3 4693.3 4706.0 4762.3 4769.0 4774.6 4775.5 4775.7 5438.2 5477.0 5543.1 5551.3 5563.3 6727.1 6777.7 6792.9 6804.1 6821.6 1602.1 1633.2 1654.7 1656.7 1676.7 1096.5 1097.1 1103.7 1116.7 1123.7 6268.7 6296.1 6348.5 6359.7 6365.7 6772.3 6818.5 6826.1 6838.1 6838.5 6030.8 6130.0 6140.0 6180.0 6193.5 3692.9 3695.3 3707.9 3722.3 3723.4 7126.8 7131.8 7155.9 7162.3 7167.1 6917.3 6924.4 6929.6 6977.2 6980.4 7314.2 7314.4 7315.9 7319.0 7319.6 6956.5 6960.8 6978.6 6995.4 7030.5 6776.8 6874.8 6879.8 6882.1 6918.7 7311.5 7317.9 7324.1 7333.6 7334.4 4624.3 4702.0 4709.5 4712.1 4724.1 6911.9 7009.6 7011.7 7014.2 7028.4 6758.6 6777.3 6777.8 6803.6 6831.7 6752.7 6789.2 6791.3 6793.3 6810.2 6555.7 6623.7 6661.4 6671.2 6676.5 6761.8 6772.8 6808.1 6821.2 6822.4 6580.2 6665.6 6677.7 6685.9 6686.6 22:30:36 INFO - PROCESS | 12275 | 22:30:36 INFO - PROCESS | 12275 | [#5] yui.html Cycles:180 Average:13422.73 Median:23790.96 stddev:15159.81 (63.7%) stddev-sans-first:15172.53 22:30:36 INFO - PROCESS | 12275 | Values: 764.1 774.1 777.8 783.7 796.6 11659.0 11723.2 11793.7 11795.9 11940.0 12760.9 14132.2 14464.6 14489.6 14506.6 683.4 803.4 815.3 821.1 823.4 825.5 828.2 828.7 829.2 829.3 862.4 863.0 866.4 867.0 868.3 853.8 854.0 857.6 858.8 868.7 637.1 639.2 640.7 643.0 643.2 12708.9 12750.9 12811.7 12817.4 12832.9 12961.3 12979.9 13002.3 13310.1 13393.8 10566.5 10609.7 10650.6 10914.3 10990.4 3451.0 3478.1 3494.0 3510.0 3525.2 49054.5 49624.0 49712.8 49809.3 49842.8 9796.0 10176.9 10520.5 10529.6 10753.6 18019.6 18090.7 18139.2 18226.5 18245.7 6934.0 7139.3 7146.3 7285.7 7369.9 3901.5 4088.8 4209.7 4227.5 4234.0 3178.3 3193.8 3197.9 3206.5 3219.3 585.6 595.7 596.5 608.0 614.5 445.0 555.3 562.9 577.1 581.8 8573.1 8704.3 8808.0 8840.9 8941.8 581.8 586.7 595.1 619.9 730.5 3798.5 3994.9 4057.3 4154.3 4161.3 53748.2 55223.4 55511.4 55577.0 55590.4 44089.0 44864.1 47286.5 47684.0 48182.3 43347.9 43492.0 45371.5 46196.5 48579.3 8666.0 8691.7 8715.6 8775.3 8887.3 32200.5 32438.8 33001.0 33180.2 34126.1 38287.2 38766.6 39556.6 39932.2 40375.8 10577.4 10616.5 10709.3 10785.9 10871.1 11868.2 12160.6 12223.1 12342.1 12979.3 11637.9 11898.3 11898.9 12187.5 12345.8 11626.0 11727.5 11898.6 12177.5 12339.4 10709.3 10773.9 10865.8 11132.5 11185.6 9241.5 9359.7 9490.6 9843.9 9862.5 9259.3 9345.6 9772.0 10018.4 10239.1 22:30:36 INFO - PROCESS | 12275 | -------- Summary: end -------- 22:30:36 INFO - PROCESS | 12275 | 22:30:37 INFO - TEST-INFO | 12275: exit 0 22:30:37 INFO - TEST-OK | dromaeo_css | took 1110940ms 22:30:37 INFO - TEST-START | kraken 22:30:37 INFO - operating with platform_type : linux_ 22:30:37 INFO - Initialising browser for kraken test... 22:30:37 INFO - TEST-INFO | started process 12509 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiRMMVU/profile http://localhost:56995/getInfo.html) 22:30:41 INFO - PROCESS | 12509 | 22:30:41 INFO - PROCESS | 12509 | (process:12582): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:30:42 INFO - PROCESS | 12509 | __metrics Screen width/height:1600/1200 22:30:42 INFO - PROCESS | 12509 | colorDepth:24 22:30:42 INFO - PROCESS | 12509 | Browser inner width/height: 1024/697 22:30:42 INFO - PROCESS | 12509 | __metrics 22:30:43 INFO - TEST-INFO | 12509: exit 0 22:30:43 INFO - Browser initialized. 22:30:43 INFO - Running cycle 1/1 for kraken test... 22:30:43 INFO - TEST-INFO | started process 12631 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpiRMMVU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:30:44 INFO - PROCESS | 12631 | 22:30:44 INFO - PROCESS | 12631 | (process:12689): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 22:30:54 INFO - PROCESS | 12631 | RSS: Main: 154877952 22:30:54 INFO - PROCESS | 12631 | 22:30:57 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-beat-detection) 22:30:57 INFO - PROCESS | 12631 | RSS: Main: 158453760 22:30:57 INFO - PROCESS | 12631 | 22:31:00 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-dft) 22:31:01 INFO - PROCESS | 12631 | RSS: Main: 160751616 22:31:01 INFO - PROCESS | 12631 | 22:31:04 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-fft) 22:31:04 INFO - PROCESS | 12631 | RSS: Main: 156585984 22:31:04 INFO - PROCESS | 12631 | 22:31:06 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56995/tests/kraken/driver.html?testName=audio-oscillator) 22:31:07 INFO - PROCESS | 12631 | RSS: Main: 156160000 22:31:07 INFO - PROCESS | 12631 | 22:31:09 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:31:10 INFO - PROCESS | 12631 | RSS: Main: 154517504 22:31:10 INFO - PROCESS | 12631 | 22:31:13 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56995/tests/kraken/driver.html?testName=imaging-darkroom) 22:31:13 INFO - PROCESS | 12631 | RSS: Main: 156123136 22:31:13 INFO - PROCESS | 12631 | 22:31:17 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56995/tests/kraken/driver.html?testName=imaging-desaturate) 22:31:17 INFO - PROCESS | 12631 | RSS: Main: 157306880 22:31:17 INFO - PROCESS | 12631 | 22:31:20 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56995/tests/kraken/driver.html?testName=json-parse-financial) 22:31:21 INFO - PROCESS | 12631 | RSS: Main: 156094464 22:31:21 INFO - PROCESS | 12631 | 22:31:22 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:31:23 INFO - PROCESS | 12631 | RSS: Main: 157302784 22:31:23 INFO - PROCESS | 12631 | 22:31:25 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:31:25 INFO - PROCESS | 12631 | RSS: Main: 155897856 22:31:25 INFO - PROCESS | 12631 | 22:31:27 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:31:28 INFO - PROCESS | 12631 | RSS: Main: 156471296 22:31:28 INFO - PROCESS | 12631 | 22:31:30 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:31:31 INFO - PROCESS | 12631 | RSS: Main: 156016640 22:31:31 INFO - PROCESS | 12631 | 22:31:34 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:31:34 INFO - PROCESS | 12631 | RSS: Main: 157642752 22:31:34 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | Cycle 1(1): loaded http://localhost:56995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56995/tests/kraken/driver.html?testName=ai-astar) 22:31:36 INFO - PROCESS | 12631 | RSS: Main: 158351360 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | __start_tp_report 22:31:36 INFO - PROCESS | 12631 | _x_x_mozilla_page_load 22:31:36 INFO - PROCESS | 12631 | _x_x_mozilla_page_load_details 22:31:36 INFO - PROCESS | 12631 | |i|pagename|runs| 22:31:36 INFO - PROCESS | 12631 | |0;ai-astar;113;107;112;111;113;123;111;111;111;112 22:31:36 INFO - PROCESS | 12631 | |1;audio-beat-detection;152;131;151;164;129;158;151;129;168;128 22:31:36 INFO - PROCESS | 12631 | |2;audio-dft;162;165;161;162;159;163;162;162;172;164 22:31:36 INFO - PROCESS | 12631 | |3;audio-fft;73;74;74;165;76;72;72;72;151;75 22:31:36 INFO - PROCESS | 12631 | |4;audio-oscillator;96;97;149;95;95;96;139;97;96;144 22:31:36 INFO - PROCESS | 12631 | |5;imaging-gaussian-blur;119;117;116;116;116;115;115;118;115;116 22:31:36 INFO - PROCESS | 12631 | |6;imaging-darkroom;146;146;147;146;148;146;146;146;146;147 22:31:36 INFO - PROCESS | 12631 | |7;imaging-desaturate;99;97;96;96;96;96;97;99;98;96 22:31:36 INFO - PROCESS | 12631 | |8;json-parse-financial;56;57;59;58;60;57;59;63;56;55 22:31:36 INFO - PROCESS | 12631 | |9;json-stringify-tinderbox;68;66;67;67;68;67;67;66;66;66 22:31:36 INFO - PROCESS | 12631 | |10;stanford-crypto-aes;86;88;95;85;89;94;87;88;87;87 22:31:36 INFO - PROCESS | 12631 | |11;stanford-crypto-ccm;127;121;127;118;125;134;136;118;121;123 22:31:36 INFO - PROCESS | 12631 | |12;stanford-crypto-pbkdf2;151;153;156;156;151;145;154;153;154;145 22:31:36 INFO - PROCESS | 12631 | |13;stanford-crypto-sha256-iterative;71;68;70;67;70;72;68;68;68;74 22:31:36 INFO - PROCESS | 12631 | __end_tp_report 22:31:36 INFO - PROCESS | 12631 | __start_cc_report 22:31:36 INFO - PROCESS | 12631 | _x_x_mozilla_cycle_collect,773 22:31:36 INFO - PROCESS | 12631 | __end_cc_report 22:31:36 INFO - PROCESS | 12631 | __startTimestamp1454740296689__endTimestamp 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | ------- Summary: start ------- 22:31:36 INFO - PROCESS | 12631 | Number of tests: 14 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#0] ai-astar Cycles:10 Average:112.40 Median:112.00 stddev:4.09 (3.6%) stddev-sans-first:4.33 22:31:36 INFO - PROCESS | 12631 | Values: 113.0 107.0 112.0 111.0 113.0 123.0 111.0 111.0 111.0 112.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:151.50 stddev:15.51 (10.2%) stddev-sans-first:16.30 22:31:36 INFO - PROCESS | 12631 | Values: 152.0 131.0 151.0 164.0 129.0 158.0 151.0 129.0 168.0 128.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.50 stddev:3.49 (2.1%) stddev-sans-first:3.67 22:31:36 INFO - PROCESS | 12631 | Values: 162.0 165.0 161.0 162.0 159.0 163.0 162.0 162.0 172.0 164.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#3] audio-fft Cycles:10 Average:90.40 Median:73.50 stddev:35.81 (48.7%) stddev-sans-first:37.42 22:31:36 INFO - PROCESS | 12631 | Values: 73.0 74.0 74.0 165.0 76.0 72.0 72.0 72.0 151.0 75.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:96.00 stddev:23.32 (24.3%) stddev-sans-first:24.14 22:31:36 INFO - PROCESS | 12631 | Values: 96.0 97.0 149.0 95.0 95.0 96.0 139.0 97.0 96.0 144.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:1.34 (1.2%) stddev-sans-first:1.00 22:31:36 INFO - PROCESS | 12631 | Values: 119.0 117.0 116.0 116.0 116.0 115.0 115.0 118.0 115.0 116.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 22:31:36 INFO - PROCESS | 12631 | Values: 146.0 146.0 147.0 146.0 148.0 146.0 146.0 146.0 146.0 147.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:97.00 stddev:1.25 (1.3%) stddev-sans-first:1.09 22:31:36 INFO - PROCESS | 12631 | Values: 99.0 97.0 96.0 96.0 96.0 96.0 97.0 99.0 98.0 96.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.50 stddev:2.36 (4.0%) stddev-sans-first:2.39 22:31:36 INFO - PROCESS | 12631 | Values: 56.0 57.0 59.0 58.0 60.0 57.0 59.0 63.0 56.0 55.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.71 22:31:36 INFO - PROCESS | 12631 | Values: 68.0 66.0 67.0 67.0 68.0 67.0 67.0 66.0 66.0 66.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#10] stanford-crypto-aes Cycles:10 Average:88.60 Median:88.00 stddev:3.31 (3.8%) stddev-sans-first:3.37 22:31:36 INFO - PROCESS | 12631 | Values: 86.0 88.0 95.0 85.0 89.0 94.0 87.0 88.0 87.0 87.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.00 stddev:6.18 (4.9%) stddev-sans-first:6.51 22:31:36 INFO - PROCESS | 12631 | Values: 127.0 121.0 127.0 118.0 125.0 134.0 136.0 118.0 121.0 123.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:153.50 stddev:3.97 (2.6%) stddev-sans-first:4.20 22:31:36 INFO - PROCESS | 12631 | Values: 151.0 153.0 156.0 156.0 151.0 145.0 154.0 153.0 154.0 145.0 22:31:36 INFO - PROCESS | 12631 | 22:31:36 INFO - PROCESS | 12631 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:2.22 (3.2%) stddev-sans-first:2.30 22:31:36 INFO - PROCESS | 12631 | Values: 71.0 68.0 70.0 67.0 70.0 72.0 68.0 68.0 68.0 74.0 22:31:36 INFO - PROCESS | 12631 | -------- Summary: end -------- 22:31:36 INFO - PROCESS | 12631 | 22:31:37 INFO - TEST-INFO | 12631: exit 0 22:31:37 INFO - TEST-OK | kraken | took 60118ms 22:31:37 INFO - SUITE-END | took 1171s 22:31:37 INFO - Completed test suite (00:19:31) 22:31:37 INFO - Working with test: dromaeo_css 22:31:37 INFO - Generating results file: dromaeo_css 22:31:37 INFO - Working with test: kraken 22:31:37 INFO - Generating results file: kraken 22:31:37 INFO - javascript benchmark 22:31:37 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,43]] 22:31:37 INFO - process_Request line: dromaeo_css 7064.38 graph.html#tests=[[72,1,43]] 22:31:37 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:31:37 INFO - process_Request line: kraken 1542.00 graph.html#tests=[[232,1,43]] 22:31:37 INFO - RETURN: dromaeo_css: 7064.38 22:31:37 INFO - RETURN: kraken: 1542.00 22:31:37 INFO - javascript benchmark 22:31:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3250.9837450812747, 3328.783629064109, 3341.398548261312, 3356.462965925451, 3373.932521349573, 5401.054815407308, 5508.421615730351, 5537.944620553793, 5561.499465048145, 5583.972080139599, 5535.225068490415, 5545.417731138233, 5546.86132846679, 5574.0, 5591.664500129995, 5040.495950404967, 5078.771455284503, 5086.796528138889, 5090.236464530331, 5137.280780690707, 5079.873003174932, 5142.0487209866105, 5148.330717006803, 5202.089634313998, 5238.423773384925, 4905.779239934193, 5041.269015992679, 5113.335266415379, 5118.6416950813455, 5125.026245013435, 5026.798928042874, 5038.193888977746, 5049.671771334888, 5078.898422031576, 5111.207762796773, 4928.950710492885, 5010.649254552182, 5020.523050310215, 5027.748612569357, 5029.823956161516, 5347.6256662033675, 5382.811601593965, 5396.298481197419, 5414.3232095988005, 5417.295751552273, 5950.196723442366, 5982.192404025488, 5992.161097446361, 5993.370696076936, 6017.548683848685, 5855.238818953551, 5970.641761494324, 5994.0, 6027.9095813562835, 6068.180795592582, 5540.418256083134, 5547.417521160261, 5558.221848941152, 5586.413426590231, 5589.217509548666, 5943.227380440515, 6080.209572755602, 6081.543884208702, 6083.148359229712, 6086.178365920544, 5859.121131830259, 5901.380355062656, 5928.555358348141, 5933.881322373529, 5968.612040217372, 5893.764249429974, 5899.292084949833, 5899.941000590025, 5904.970475147683, 5909.995300798874, 5863.912041319383, 5894.2926848778425, 5914.319853216935, 5992.940070599326, 6077.270727512727, 5935.0, 5949.940500595025, 5952.7023648817385, 5964.880702385928, 5984.581079324493, 4515.480719717209, 4522.321651752198, 4523.683342166082, 4554.43069616298, 4557.293619488984, 3972.920541589152, 4052.8328119569114, 4068.3287257602756, 4081.6122468365456, 4127.504699436026, 5532.0, 5546.86132846674, 5563.693996830213, 5579.637323573955, 5604.719764011865, 5906.202662640574, 5925.40745925404, 5954.493868021266, 5970.76116955317, 6013.338532761392, 5488.4785945335125, 5499.340079190442, 5508.7521061552325, 5548.805791797267, 5616.887662246814, 5027.673201241908, 5071.949280507221, 5072.4673909239, 5086.364204474441, 5118.61610379223, 6131.877362452726, 6164.321924588292, 6191.9690401548605, 6195.659238741822, 6246.031865060922, 5915.438033386821, 5946.613470124428, 5958.6424814511265, 5960.225170727777, 5967.194428752063, 6116.3883611638485, 6177.876442471035, 6180.351063138306, 6184.288806787277, 6203.100550420074, 5897.439743224387, 5905.261842269716, 5916.467517923407, 5916.73374698131, 5925.822225333247, 5990.940090599212, 6011.6693581853415, 6014.398560144125, 6015.48868346178, 6032.547558933185, 5694.686792226302, 5856.824295271149, 5874.441928016831, 5878.735456904535, 5937.2578427696535, 5860.09168578871, 5871.647701137946, 5875.20684707559, 5876.823695289148, 5879.118132280192, 5699.8860022800145, 5756.539476841759, 5811.82564523065, 5816.098504731774, 5819.912701309569, 5741.483266506035, 5859.736311866061, 5896.8820623586425, 5920.615160014585, 5972.432618901197, 5691.402402747652, 5721.742521586455, 5723.112917497794, 5726.513246373938, 5730.054541000688], "unit": "score", "name": "dojo.html", "value": 5490.7156397917415}, {"lowerIsBetter": false, "replicates": [515.556621305677, 551.3521612105775, 556.1685280505643, 558.6340946679925, 571.2202843119138, 35891.64108358919, 36884.127166647515, 37103.25793484132, 37247.627523724754, 37273.81363093187, 37402.8129859351, 38116.618833811655, 38292.425613615815, 38359.61640383596, 38386.23227535448, 8224.835503289945, 8493.532855692934, 8510.276626486726, 8516.87224691627, 8530.488170709747, 8318.875216871751, 8435.746927592152, 8478.279346255576, 8479.618417171243, 8485.44844585103, 8553.529555874455, 8591.656333746643, 8591.914080859175, 8597.140285971416, 8617.61220745068, 8477.406581539295, 8515.063343032261, 8523.914760852436, 8564.87152692707, 8605.096464871162, 8464.153584641548, 8545.27365173961, 8585.61364738582, 8593.398462107654, 8606.655733770642, 30985.225369365722, 36807.0, 37443.81278093619, 37466.06334841623, 37607.623923760686, 2841.5169421198448, 3215.4533729265845, 3253.96746032539, 4015.99600099975, 4032.959670403288, 26687.866560667266, 26818.46363072747, 26903.596446053325, 27029.864850675818, 27272.590911136347, 3740.513733214692, 3765.171662234304, 3765.35988881888, 3775.6979441644603, 3804.2201348723447, 189762.0, 190382.0, 190607.0, 191931.0, 233984.9999999983, 54464.45535544594, 55798.442015580134, 55831.441685583435, 55913.7204313984, 55997.72001139968, 55431.0, 62656.686716567034, 63943.36056639467, 63999.68000159969, 64215.0, 14770.0, 14906.403743850124, 14959.775603365959, 14962.177080260473, 14983.0, 12109.878901211052, 12217.389130543437, 12264.693382665504, 12271.141020128684, 12287.0, 18886.43340699781, 19135.330263440712, 19767.209311627375, 19828.405147845588, 19841.38874739056, 7705.267999540035, 7851.214878512217, 7902.0, 7964.4823086500355, 8080.595970201584, 1013.7935856330943, 1016.8118898003893, 1024.9692509224735, 1071.3571856885962, 1084.2301965604508, 30228.69771302259, 30294.697053029628, 30347.848260758554, 30601.234969125504, 30668.539971900438, 1081.6917178604217, 1102.7518808268235, 1158.3571118029406, 1164.6797130788932, 1195.235049568277, 15815.683686326209, 16021.0, 16104.838951610334, 16260.67478650444, 16387.59031024234, 317890.0, 318313.0, 319266.0, 319504.0, 320395.0, 49369.259461108115, 49918.750406248466, 50098.24852627214, 50153.24770128451, 50265.497345026815, 1346.0846624295573, 1354.7553609106135, 1360.2246719370062, 1370.8286464191976, 1373.5192682561024, 28755.71244287614, 30003.849980749957, 30036.0, 30246.395072098876, 31494.37011259716, 47558.52441475541, 47660.285095724284, 47708.0, 47766.761166193945, 47781.28328075012, 247073.0, 248399.0, 248740.0, 251037.0, 251148.0, 29007.419851602426, 31637.209069772518, 31950.840245798623, 32018.0, 32202.0, 38659.806700966314, 40887.795561022, 41889.0, 42353.36469952892, 42437.15125697407, 35031.29937401289, 35368.646313536534, 35549.466757999166, 35727.64272357243, 35993.64006359903, 35764.64235357613, 36008.81995590005, 36312.0, 38240.0, 39659.80170099131, 36920.26159476849, 36955.0, 36975.630243698295, 37412.0, 37498.8125059373, 28167.57748633813, 32005.199870003435, 34845.825770870986, 35688.322250157325, 36126.0, 25838.354041149123, 25843.353916152246, 25873.353166170997, 26150.0, 26386.20841374762], "unit": "score", "name": "ext.html", "value": 18161.713222362065}, {"lowerIsBetter": false, "replicates": [374.36358191075175, 376.6873494999151, 378.21897781082066, 378.9981050094749, 382.8334674416627, 16376.0, 17146.82853171468, 17177.3129074837, 17460.0, 17950.10249487527, 11240.437978101083, 12528.686782830433, 16844.57888552787, 16997.745033824503, 17058.744118838196, 4909.288153217782, 5422.40353561108, 5648.435156484339, 5702.315722113352, 5702.515286200678, 5513.338399392059, 5527.309086364205, 5552.694601796919, 5558.249636299089, 5570.387257401682, 5597.132444471114, 6178.104174894637, 6251.218597675291, 6272.968635156841, 6299.622022678654, 6201.007838745802, 6233.34549872266, 6240.781572644935, 6245.687715614224, 6248.437640612344, 5383.730813459311, 5458.645188062763, 5466.508014278734, 5490.478404551562, 5509.035918714249, 12574.68563285916, 12963.546275880393, 13020.0, 13056.738865222738, 16968.3212671493, 1935.5741736818018, 1981.4650044487908, 2063.3603582889355, 2280.4754906371627, 2729.1539622717023, 9392.953035234848, 9830.508474576243, 13822.792658110136, 13874.514391996232, 14894.255287235595, 1757.2707326459504, 1774.547490389955, 1835.8990255535941, 1838.2646941223484, 1846.3630047633544, 66277.33722662808, 66456.0, 68097.3190268096, 69358.0, 71985.28014719838, 15138.848611513744, 15739.0, 15786.447474338343, 15822.52532424029, 15930.60173495672, 24320.635190472156, 24339.634905476432, 24601.876990614932, 24749.5050098997, 24973.750262497506, 7371.926280737124, 7508.361789247866, 7879.527228366316, 7898.328642065489, 7921.881171782428, 7611.3530349919765, 7627.466077374531, 7636.198199189116, 7639.809004774814, 7652.579108149105, 4404.933925991113, 4469.932951005738, 4538.72767633943, 4565.246734288871, 4585.541445855388, 1844.7509586205958, 1954.3192854145423, 1958.1384190955935, 1966.6853303471662, 1991.541945352577, 934.4019827310527, 960.9519524023771, 987.5062468765617, 1074.7689246811817, 1085.159001773616, 17436.12819359027, 17522.29910803579, 17709.911450442924, 17805.287788488575, 17913.820861791475, 985.6205360936091, 1004.4726518577659, 1018.8471729240525, 1026.3123707116101, 1030.0729343590829, 10114.544845481823, 10235.078842904175, 10315.0, 10378.792424151474, 10387.532561034772, 383504.0, 391310.0, 567053.0, 573751.0, 579788.0, 69053.0, 69593.0, 77411.61294193605, 78386.0, 79502.0, 505.815377387251, 516.5118962580401, 518.289942778396, 518.3857129301714, 520.7734635433599, 10367.688969330931, 10883.945580272048, 10976.451177441255, 11008.568886044763, 15052.623684407978, 30714.0, 31021.534676980315, 31521.8423907879, 31751.364972699954, 31757.8412107938, 41495.377569335884, 41730.58269417267, 41806.1638767229, 41883.0, 41953.0, 7460.975658380008, 7750.341220996278, 7971.880421793562, 7977.2022797719765, 8076.676932922853, 9438.0, 11932.403379831147, 12024.579139730067, 12042.698932526757, 12046.216995895238, 10369.429681367597, 10509.9474502627, 10689.0, 10910.0, 11004.284721493077, 10236.641717539851, 10476.68569942903, 10645.148388129086, 10689.51897164645, 10750.247482676137, 9779.559919803769, 10702.090322322378, 10771.6229931952, 10832.729181770204, 11088.279261847954, 7673.232676732506, 7794.727184548514, 7888.6450109744055, 7889.763307100796, 7897.210278972057, 9126.315526335684, 10184.643537476153, 10205.948970255102, 10257.692269231935, 10407.895921040996], "unit": "score", "name": "jquery.html", "value": 8480.727633537177}, {"lowerIsBetter": false, "replicates": [1491.2916364726752, 1492.4477943161028, 1696.6861130690822, 1817.182267979408, 1853.6570734414142, 7212.386947109502, 7917.524948503094, 8016.879746803796, 8242.587870606469, 8280.378971577133, 7974.7208847690345, 8022.197780221975, 8093.2311430414165, 8101.959490202556, 8108.148644392342, 2326.336993956723, 2342.4495243617735, 2363.1847012780563, 2364.243442098529, 2369.6919400477914, 2336.544373847092, 2365.4559451326118, 2369.1589485732575, 2373.2405630198346, 2373.5134297469062, 2022.201230513946, 2290.278562252885, 2330.4057465346395, 2338.018032426385, 2353.105819788478, 2287.5196208796006, 2290.702208712865, 2295.908163673451, 2313.34069790109, 2322.918697845576, 2283.155232563962, 2294.1167650454527, 2305.354500739779, 2309.3880121767743, 2323.7560056194193, 8047.396445266629, 8086.393520485987, 8086.919130808734, 8105.1084380718075, 8109.95945020277, 4936.80252789888, 5020.573251273646, 5022.4977502249485, 5057.266696329012, 5068.467810879878, 3112.766542509321, 3119.703628155344, 3201.775875688703, 3219.5009773484912, 3257.0228931320744, 990.7275499237695, 996.2378780233128, 1002.1982414068789, 1005.8491226316111, 1021.6117875207374, 11226.607068752635, 11287.322760634388, 11300.378479183642, 11356.829647555292, 11386.202965792398, 4551.40831691878, 4564.1556312082375, 4619.214733495314, 4630.791614377294, 4660.39414876064, 9609.663661771805, 9646.0, 9669.564869580885, 9676.467794271382, 9680.56437460316, 4969.503049695001, 4978.203487442064, 4979.053979743837, 4982.6512144149565, 5018.096742586369, 4478.305862591304, 4481.596656300949, 4488.192125417391, 4534.229181039232, 4547.386102876136, 3842.9039274018373, 3888.786116763605, 3913.354296541039, 3923.6664883484655, 3941.7437866538585, 1161.9477123529462, 1243.7263801963554, 1254.3101294288106, 1258.8867001969866, 1276.9744605107846, 1058.142904247562, 1058.227493929436, 1105.165599972016, 1242.7763002659428, 1351.9256440895845, 7400.777976660709, 7487.925120748831, 7509.586972716553, 7569.167391586921, 7582.241775822374, 1149.8850114988434, 1158.7566611011782, 1167.480471190312, 1168.6669299249672, 1169.4328250798355, 5789.160571717078, 5843.824685259449, 5864.266966629171, 5876.177335173079, 5900.055991041413, 9424.811503769886, 9837.80324393508, 9924.751881203028, 9978.301518893608, 10043.096121348968, 9850.359726617748, 9854.359466634645, 9872.111509963994, 9886.505674716236, 9946.751331216778, 7476.813079672943, 7720.8455830884195, 7730.845383092306, 7763.650635721406, 7792.454528183086, 7308.451866110169, 7311.524750891175, 7358.337749602561, 7362.116546014298, 7387.852242955219, 8551.871721924052, 8849.778755530906, 8932.50871202064, 8981.46111233302, 9013.954930225307, 8758.386912916034, 8818.91181088181, 8848.203661670223, 8885.600147993486, 8942.552872356226, 7030.578165310098, 7099.183593886562, 7116.252793456612, 7137.286271372821, 7150.462650530161, 7625.961870190614, 7688.923110768821, 7701.88447173304, 7726.1501234863, 7727.845443091219, 6538.640374779243, 7253.56478611285, 7280.0535930328715, 7346.412287017132, 7463.962680186564, 7206.9030573236005, 7259.9274007259255, 7318.670659820427, 7357.448191385561, 7374.410047196318, 7295.379892709179, 7367.815804604714, 7373.668184931584, 7383.2985866342615, 7410.481266311306, 6496.317886621837, 6571.474282057328, 6623.933760662332, 6628.436582890508, 6641.867162656817, 6806.727730890709, 6843.589384636938, 6843.7604683835825, 6870.828229294308, 6879.552829066095], "unit": "score", "name": "mootools.html", "value": 4669.441072161247}, {"lowerIsBetter": false, "replicates": [348.2634228606497, 356.9179088809574, 358.98564057437704, 360.3225935241745, 364.531576923653, 6149.692515374225, 6269.623822570649, 6277.843053923654, 6307.936920630798, 6310.116583678288, 6310.4320611144985, 6311.968440157804, 6314.905276420845, 6319.178506794122, 6347.36526347365, 4818.951810481885, 4820.758962051901, 4832.3717916670785, 4838.371011768465, 4840.6369522285795, 4834.2265237562, 4836.927446088312, 4841.104395686792, 4851.442084160331, 4852.587530059932, 4711.9764401177945, 4812.68717533361, 4824.5416685415, 4838.250071238964, 4841.56425921667, 4789.449213340476, 4805.903881922342, 4814.590759785422, 4817.879553011167, 4827.106985207713, 4211.684123690705, 4216.325387937946, 4235.724677895958, 4238.96145444365, 4254.298040823261, 5931.703414829241, 6074.2103526541705, 6083.634981901056, 6094.055421409645, 6096.451319381233, 5527.613067085305, 5539.113741801292, 5545.195946587723, 5552.278203833516, 5562.415946325658, 6677.332266773333, 6687.531872768908, 6706.396424321834, 6711.295313992009, 6726.764563240263, 4582.931256031162, 4584.243599806028, 4588.38056862326, 4605.516420775803, 4605.930911036304, 6831.077804496379, 7012.9298707013295, 7022.92977070233, 7027.82430439238, 7067.116610423697, 4650.883727906829, 4680.4149481314835, 4681.321208424827, 4693.272542755878, 4705.976470117627, 4762.285657151455, 4768.976155119202, 4774.570288673966, 4775.5224477551965, 4775.71345719258, 5438.238646589481, 5476.972615136899, 5543.1408131739645, 5551.278333816578, 5563.332400112013, 6727.125473688389, 6777.695003724844, 6792.864142717118, 6804.149481314836, 6821.55659882116, 1602.110828490199, 1633.207894171326, 1654.6525229701656, 1656.6521030583472, 1676.740105283683, 1096.5010920031366, 1097.1332647208776, 1103.7185517692938, 1116.6538373104363, 1123.702218911989, 6268.749250029948, 6296.118543403927, 6348.523860710465, 6359.682015899279, 6365.681715914186, 6772.288909664513, 6818.454523638097, 6826.078479405316, 6838.076859623887, 6838.452923766087, 6030.758769649253, 6130.049842274455, 6140.048292514667, 6180.042093475518, 6193.535484838565, 3692.8707495237536, 3695.316366472211, 3707.888763337104, 3722.2927643748144, 3723.404255319136, 7126.821829454201, 7131.750388736369, 7155.856882862314, 7162.283771622796, 7167.139943206745, 6917.342852429011, 6924.4114250289285, 6929.618870962146, 6977.232504424509, 6980.371766541036, 7314.232005639331, 7314.354270289249, 7315.926840731631, 7319.0, 7319.560826350436, 6956.5478243913985, 6960.756373526902, 6978.581285122909, 6995.440364770704, 7030.50786444944, 6776.7628133015105, 6874.793756187322, 6879.828004299932, 6882.139732533434, 6918.723251070102, 7311.488195826241, 7317.853642927218, 7324.121105467378, 7333.559986400833, 7334.413246940126, 4624.3294722265755, 4702.0, 4709.5055019223855, 4712.128256272601, 4724.1260366830875, 6911.896321555281, 7009.614471204132, 7011.6844741985715, 7014.158301003912, 7028.402585780266, 6758.594484330956, 6777.2883847195335, 6777.796666100025, 6803.625800580818, 6831.726730930906, 6752.69612867432, 6789.219239787488, 6791.252962174058, 6793.320667933167, 6810.216825065181, 6555.737770489127, 6623.735050597922, 6661.367170118831, 6671.199456065303, 6676.465882729273, 6761.797146085625, 6772.796816095525, 6808.114945057111, 6821.249662537216, 6822.351876571916, 6580.159476994777, 6665.600063996176, 6677.6661166940485, 6685.933140668531, 6686.632235226914], "unit": "score", "name": "prototype.html", "value": 5047.007250435675}, {"lowerIsBetter": false, "replicates": [764.121260550367, 774.1097737601758, 777.8211011467358, 783.721778768537, 796.5618909599723, 11659.0, 11723.179377443583, 11793.70515737107, 11795.882041179586, 11940.044796416276, 12760.936195319033, 14132.152070875729, 14464.638384040405, 14489.63775905603, 14506.637334066627, 683.4361651637395, 803.4295650088444, 815.3273549321804, 821.1255013410728, 823.3618945317397, 825.5376988886243, 828.1635548096436, 828.7348048624442, 829.1873963515728, 829.340674164041, 862.3790870573177, 863.0290922711949, 866.3762091294258, 866.9942866275122, 868.3183700794877, 853.7950891785989, 854.0, 857.618359829876, 858.845407826591, 868.7089824908631, 637.1271358239196, 639.2488825629866, 640.7405000974566, 643.0, 643.1960049937578, 12708.872911270953, 12750.936245318806, 12811.679708007281, 12817.35913204336, 12832.871671283261, 12961.287129207889, 12979.935100324532, 13002.284874332003, 13310.134841235289, 13393.799093013613, 10566.471676416148, 10609.68170954865, 10650.627228046982, 10914.290571112932, 10990.395528245943, 3450.9827450862585, 3478.087748550367, 3493.9650603494147, 3510.0, 3525.2068284636007, 49054.509454905354, 49624.0, 49712.75143624295, 49809.25286120711, 49842.7507862462, 9795.951020244996, 10176.949115254376, 10520.473976301308, 10529.568619632635, 10753.569857205624, 18019.639607207784, 18090.728639070163, 18139.18373673188, 18226.544336391697, 18245.7263141053, 6933.965330173317, 7139.286071392923, 7146.32109949554, 7285.672144753499, 7369.852602948018, 3901.4733011043713, 4088.7955602220363, 4209.74741515504, 4227.492700875853, 4234.0, 3178.3484385700876, 3193.8243396612943, 3197.872085116616, 3206.5190221466964, 3219.323941972212, 585.5696063393402, 595.6524333247179, 596.5227817745786, 608.0210860514568, 614.5390956782413, 444.97997590108525, 555.3197333266716, 562.9127485239794, 577.0853197681721, 581.7614777941023, 8573.099824518336, 8704.338184615071, 8807.955960220286, 8840.860535598895, 8941.821163576693, 581.7789240088824, 586.7037146241121, 595.0508938243495, 619.9008158694587, 730.455810421229, 3798.4682144499793, 3994.8801535953967, 4057.2899742544937, 4154.252234597801, 4161.334186530141, 53748.19377709337, 55223.44776552183, 55511.444885551435, 55577.0, 55590.44409555852, 44089.0, 44864.10271794546, 47286.52713472821, 47684.0, 48182.27726584104, 43347.9163020927, 43492.0, 45371.54628453673, 46196.538034619894, 48579.271310930366, 8665.956670216608, 8691.652333906826, 8715.564221788758, 8775.341849361452, 8887.289016878764, 32200.516992245604, 32438.83780581082, 33001.0, 33180.1704957378, 34126.146846329044, 38287.23425531529, 38766.6123338763, 39556.60443395529, 39932.2013559733, 40375.798121009204, 10577.36535807854, 10616.52225649863, 10709.250352475563, 10785.946070269598, 10871.130309575374, 11868.169228153947, 12160.635180944586, 12223.083268755057, 12342.13605047638, 12979.286139262054, 11637.88362116368, 11898.345590992578, 11898.940505297418, 12187.451564679788, 12345.814812777995, 11626.0, 11727.47226374798, 11898.643040708792, 12177.512899483922, 12339.383030848601, 10709.303895246783, 10773.946130269298, 10865.782684346426, 11132.499037543168, 11185.552577897119, 9241.537923103953, 9359.719208423758, 9490.572924218288, 9843.901560984299, 9862.506874656381, 9259.259259259377, 9345.626174953197, 9772.0, 10018.39889606626, 10239.129673977795], "unit": "score", "name": "yui.html", "value": 6235.812680560421}], "name": "dromaeo_css", "value": 7064.3813799387535}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 112.0, 111.0, 113.0, 123.0, 111.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [152.0, 131.0, 151.0, 164.0, 129.0, 158.0, 151.0, 129.0, 168.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [162.0, 165.0, 161.0, 162.0, 159.0, 163.0, 162.0, 162.0, 172.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 74.0, 165.0, 76.0, 72.0, 72.0, 72.0, 151.0, 75.0], "unit": "score", "name": "audio-fft", "value": 90.4}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 149.0, 95.0, 95.0, 96.0, 139.0, 97.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 110.4}, {"lowerIsBetter": true, "replicates": [119.0, 117.0, 116.0, 116.0, 116.0, 115.0, 115.0, 118.0, 115.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [99.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0, 99.0, 98.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 59.0, 58.0, 60.0, 57.0, 59.0, 63.0, 56.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.8}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 95.0, 85.0, 89.0, 94.0, 87.0, 88.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.6}, {"lowerIsBetter": true, "replicates": [127.0, 121.0, 127.0, 118.0, 125.0, 134.0, 136.0, 118.0, 121.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [151.0, 153.0, 156.0, 156.0, 151.0, 145.0, 154.0, 153.0, 154.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 70.0, 67.0, 70.0, 72.0, 68.0, 68.0, 68.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1541.9999999999995}]} 22:31:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,43]]", "result": "1542.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,43]]", "result": "7064.38"}}} 22:31:38 INFO - Return code: 0 22:31:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:31:38 INFO - # TBPL SUCCESS # 22:31:38 INFO - Running post-action listener: _resource_record_post_action 22:31:38 INFO - Running post-run listener: _resource_record_post_run 22:31:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 546566144; Read time: 0; Write time: 618148 22:31:39 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 250449920; Read time: 0; Write time: 333852 22:31:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 295518208; Read time: 0; Write time: 284296 22:31:39 INFO - Running post-run listener: _upload_blobber_files 22:31:39 INFO - Blob upload gear active. 22:31:39 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:31:39 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 22:31:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 22:31:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Firefox -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 22:31:39 INFO - (blobuploader) - INFO - Open directory for files ... 22:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:31:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:40 INFO - (blobuploader) - INFO - Done attempting. 22:31:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:31:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:31:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:31:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:31:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:31:41 INFO - (blobuploader) - INFO - Done attempting. 22:31:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:31:41 INFO - Return code: 0 22:31:41 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:31:41 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:31:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d6e86d78920dab70cab2c670186939f672b98a4cccaa218651515621df9a0155897844c88826e2411cad71bd4617dec9fff2cd923f917a507abfbac03aa3b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f71062182deef8f93ddc8613917641b4bad806272c999c6f41057d0dd1945e48f905bc71b738a6923dee548bc168b3a7a53d7624cddad9c148daac9ab3613f"} 22:31:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:31:41 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:31:41 INFO - Contents: 22:31:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d6e86d78920dab70cab2c670186939f672b98a4cccaa218651515621df9a0155897844c88826e2411cad71bd4617dec9fff2cd923f917a507abfbac03aa3b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f71062182deef8f93ddc8613917641b4bad806272c999c6f41057d0dd1945e48f905bc71b738a6923dee548bc168b3a7a53d7624cddad9c148daac9ab3613f"} 22:31:41 INFO - Running post-run listener: copy_logs_to_upload_dir 22:31:41 INFO - Copying logs to upload dir... 22:31:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 22:31:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.297618 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-02-05 22:31:41.158929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:41.162322) ========= 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 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/Firefox/sha512/91d6e86d78920dab70cab2c670186939f672b98a4cccaa218651515621df9a0155897844c88826e2411cad71bd4617dec9fff2cd923f917a507abfbac03aa3b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f71062182deef8f93ddc8613917641b4bad806272c999c6f41057d0dd1945e48f905bc71b738a6923dee548bc168b3a7a53d7624cddad9c148daac9ab3613f"} build_url:https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011521 build_url: 'https://queue.taskcluster.net/v1/task/Ac4GyaljTsmncsaggmCH7g/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91d6e86d78920dab70cab2c670186939f672b98a4cccaa218651515621df9a0155897844c88826e2411cad71bd4617dec9fff2cd923f917a507abfbac03aa3b1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9f71062182deef8f93ddc8613917641b4bad806272c999c6f41057d0dd1945e48f905bc71b738a6923dee548bc168b3a7a53d7624cddad9c148daac9ab3613f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:41.187726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:41.188089) ========= 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=920470bf432669ad7e3a5387000001ca-1454738311.820684-650765949 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 22:31:41.270071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 22:31:41.270449) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 22:31:41.270763) ========= ========= Total master_lag: 0.28 =========