builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1455301134.75 results: success (0) buildid: 20160212073253 builduid: f8b55649dff94e81bb8350b00276eb9e revision: 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.752852) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.753456) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.753749) ========= 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006316 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.776781) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.777082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.791305) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.791596) ========= 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.841493) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.841828) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.842198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:54.842469) ========= 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-12 10:18:55-- 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% 47.0M=0s 2016-02-12 10:18:55 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.008822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.009134) ========= 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.058665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.059026) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 --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 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 --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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-12 10:18:55,455 truncating revision to first 12 chars 2016-02-12 10:18:55,455 Setting DEBUG logging. 2016-02-12 10:18:55,455 attempt 1/10 2016-02-12 10:18:55,455 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/218d16a9ddcc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 10:18:55,730 unpacking tar archive at: mozilla-central-218d16a9ddcc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571934 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.643829) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.644170) ========= echo 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515'] 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 program finished with exit code 0 elapsedTime=0.004668 script_repo_revision: '218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.698657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.699217) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 10:18:55.710159) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-02-12 10:18:55.710507) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:18:56 INFO - MultiFileLogger online at 20160212 10:18:56 in /builds/slave/test-pgo 10:18:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:18:56 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:18:56 INFO - {'append_to_log': False, 10:18:56 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:18:56 INFO - 'blob_upload_branch': 'Firefox', 10:18:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:18:56 INFO - 'branch': 'Firefox', 10:18:56 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:56 INFO - 'config_files': ('talos/linux_config.py',), 10:18:56 INFO - 'default_actions': ('clobber', 10:18:56 INFO - 'read-buildbot-config', 10:18:56 INFO - 'download-and-extract', 10:18:56 INFO - 'populate-webroot', 10:18:56 INFO - 'create-virtualenv', 10:18:56 INFO - 'install', 10:18:56 INFO - 'run-tests'), 10:18:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:56 INFO - 'download_minidump_stackwalk': True, 10:18:56 INFO - 'download_symbols': 'ondemand', 10:18:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:56 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:56 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:56 INFO - 'installer_path': 'installer.exe', 10:18:56 INFO - 'log_level': 'info', 10:18:56 INFO - 'log_name': 'talos', 10:18:56 INFO - 'log_to_console': True, 10:18:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:18:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:18:56 INFO - 'opt_config_files': (), 10:18:56 INFO - 'pip_index': False, 10:18:56 INFO - 'sps_profile': False, 10:18:56 INFO - 'sps_profile_interval': 0, 10:18:56 INFO - 'suite': 'dromaeojs', 10:18:56 INFO - 'system_bits': '32', 10:18:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:56 INFO - 'title': 'talos-linux64-ix-016', 10:18:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:56 INFO - 'use_talos_json': True, 10:18:56 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:18:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:56 INFO - 'work_dir': 'build'} 10:18:56 INFO - ##### 10:18:56 INFO - ##### Running clobber step. 10:18:56 INFO - ##### 10:18:56 INFO - Running pre-action listener: _resource_record_pre_action 10:18:56 INFO - Running main action method: clobber 10:18:56 INFO - rmtree: /builds/slave/test-pgo/build 10:18:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:18:56 INFO - Running post-action listener: _resource_record_post_action 10:18:56 INFO - ##### 10:18:56 INFO - ##### Running read-buildbot-config step. 10:18:56 INFO - ##### 10:18:56 INFO - Running pre-action listener: _resource_record_pre_action 10:18:56 INFO - Running main action method: read_buildbot_config 10:18:56 INFO - Using buildbot properties: 10:18:56 INFO - { 10:18:56 INFO - "project": "", 10:18:56 INFO - "product": "firefox", 10:18:56 INFO - "script_repo_revision": "production", 10:18:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:18:56 INFO - "repository": "", 10:18:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:18:56 INFO - "buildid": "20160212073253", 10:18:56 INFO - "pgo_build": "True", 10:18:56 INFO - "basedir": "/builds/slave/test-pgo", 10:18:56 INFO - "buildnumber": 355, 10:18:56 INFO - "slavename": "talos-linux64-ix-016", 10:18:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:18:56 INFO - "platform": "ubuntu64_hw", 10:18:56 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:18:56 INFO - "branch": "mozilla-central", 10:18:56 INFO - "repo_path": "mozilla-central", 10:18:56 INFO - "revision": "218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515", 10:18:56 INFO - "stage_platform": "linux64-pgo", 10:18:56 INFO - "builduid": "f8b55649dff94e81bb8350b00276eb9e", 10:18:56 INFO - "slavebuilddir": "test" 10:18:56 INFO - } 10:18:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 10:18:56 INFO - Running post-action listener: _resource_record_post_action 10:18:56 INFO - ##### 10:18:56 INFO - ##### Running download-and-extract step. 10:18:56 INFO - ##### 10:18:56 INFO - Running pre-action listener: _resource_record_pre_action 10:18:56 INFO - Running main action method: download_and_extract 10:18:56 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:18:56 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')]} 10:18:56 INFO - https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:18:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/test_packages.json 10:18:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/test_packages.json 10:18:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:18:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:18:57 INFO - Downloaded 1448 bytes. 10:18:57 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:18:57 INFO - Using the following test package requirements: 10:18:57 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:57 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:18:57 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:18:57 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'jsshell-linux-x86_64.zip'], 10:18:57 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:18:57 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:57 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:18:57 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:18:57 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:18:57 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:57 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:57 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:18:57 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:18:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:57 INFO - https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:18:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:18:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:18:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:18:58 INFO - Downloaded 23295932 bytes. 10:18:58 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'] 10:18:58 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 10:18:59 INFO - Return code: 0 10:18:59 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 10:18:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:59 INFO - https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:18:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 10:18:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:18:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:19:01 INFO - Downloaded 23295932 bytes. 10:19:01 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'] 10:19:01 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 10:19:03 INFO - Return code: 0 10:19:03 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')]} 10:19:03 INFO - https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:19:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:19:03 INFO - Downloaded 10706696 bytes. 10:19:03 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'] 10:19:03 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 10:19:04 INFO - Return code: 0 10:19:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:04 INFO - https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:19:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:19:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:19:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c00jjlo2QVStfOMkVwPbxw/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 10:19:05 INFO - Downloaded 56443186 bytes. 10:19:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:19:05 INFO - mkdir: /builds/slave/test-pgo/properties 10:19:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:19:05 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:19:05 INFO - Contents: 10:19:05 INFO - build_url:https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 10:19:06 INFO - Running post-action listener: _resource_record_post_action 10:19:06 INFO - Running post-action listener: set_extra_try_arguments 10:19:06 INFO - ##### 10:19:06 INFO - ##### Running populate-webroot step. 10:19:06 INFO - ##### 10:19:06 INFO - Running pre-action listener: _resource_record_pre_action 10:19:06 INFO - Running main action method: populate_webroot 10:19:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:06 INFO - '--tppagecycles', 10:19:06 INFO - '7'], 10:19:06 INFO - 'tests': ['tsvgm']}}, 10:19:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:19:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:19:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'tests': ['damp', 'tps']}, 10:19:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['damp', 'tps']}, 10:19:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:19:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:06 INFO - 'other': {'tests': ['a11yr', 10:19:06 INFO - 'ts_paint', 10:19:06 INFO - 'tpaint', 10:19:06 INFO - 'sessionrestore', 10:19:06 INFO - 'sessionrestore_no_auto_restore']}, 10:19:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['a11yr', 10:19:06 INFO - 'ts_paint', 10:19:06 INFO - 'tpaint', 10:19:06 INFO - 'sessionrestore', 10:19:06 INFO - 'sessionrestore_no_auto_restore']}, 10:19:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['a11yr', 10:19:06 INFO - 'ts_paint', 10:19:06 INFO - 'tpaint', 10:19:06 INFO - 'sessionrestore', 10:19:06 INFO - 'sessionrestore_no_auto_restore']}, 10:19:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['a11yr', 10:19:06 INFO - 'ts_paint', 10:19:06 INFO - 'tpaint', 10:19:06 INFO - 'sessionrestore', 10:19:06 INFO - 'sessionrestore_no_auto_restore']}, 10:19:06 INFO - 'other_l64': {'tests': ['a11yr', 10:19:06 INFO - 'ts_paint', 10:19:06 INFO - 'tpaint', 10:19:06 INFO - 'sessionrestore', 10:19:06 INFO - 'sessionrestore_no_auto_restore']}, 10:19:06 INFO - 'other_nol64': {'tests': ['a11yr', 10:19:06 INFO - 'ts_paint', 10:19:06 INFO - 'tpaint', 10:19:06 INFO - 'sessionrestore', 10:19:06 INFO - 'sessionrestore_no_auto_restore']}, 10:19:06 INFO - 'svgr': {'tests': ['tsvgx', 10:19:06 INFO - 'tsvgr_opacity', 10:19:06 INFO - 'tart', 10:19:06 INFO - 'tscrollx', 10:19:06 INFO - 'cart']}, 10:19:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['tsvgx', 10:19:06 INFO - 'tsvgr_opacity', 10:19:06 INFO - 'tart', 10:19:06 INFO - 'tscrollx', 10:19:06 INFO - 'cart']}, 10:19:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'tests': ['tp5o']}, 10:19:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'talos_options': ['--e10s'], 10:19:06 INFO - 'tests': ['tp5o']}, 10:19:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'talos_options': ['--xperf_path', 10:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:06 INFO - 'tests': ['tp5n']}, 10:19:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:06 INFO - 'talos_options': ['--e10s', 10:19:06 INFO - '--xperf_path', 10:19:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:06 INFO - 'tests': ['tp5n']}}, 10:19:06 INFO - 'talos.zip': {'path': '', 10:19:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:06 INFO - Running post-action listener: _resource_record_post_action 10:19:06 INFO - ##### 10:19:06 INFO - ##### Running create-virtualenv step. 10:19:06 INFO - ##### 10:19:06 INFO - Running pre-action listener: _resource_record_pre_action 10:19:06 INFO - Running main action method: create_virtualenv 10:19:06 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:19:06 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 10:19:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:19:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:06 INFO - Using real prefix '/usr' 10:19:06 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:19:07 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:09 INFO - Installing pip.................done. 10:19:09 INFO - Return code: 0 10:19:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:09 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 10:19:09 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 10:19:09 INFO - Using env: {'DISPLAY': ':0', 10:19:09 INFO - 'HOME': '/home/cltbld', 10:19:09 INFO - 'LANG': 'en_US.UTF-8', 10:19:09 INFO - 'LANGUAGE': 'en_US:en', 10:19:09 INFO - 'LOGNAME': 'cltbld', 10:19:09 INFO - 'MAIL': '/var/mail/cltbld', 10:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:09 INFO - 'MOZ_NO_REMOTE': '1', 10:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:09 INFO - 'NO_EM_RESTART': '1', 10:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:09 INFO - 'SHELL': '/bin/bash', 10:19:09 INFO - 'SHLVL': '1', 10:19:09 INFO - 'TERM': 'linux', 10:19:09 INFO - 'TMOUT': '86400', 10:19:09 INFO - 'USER': 'cltbld', 10:19:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:09 INFO - '_': '/tools/buildbot/bin/python'} 10:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:09 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 10:19:09 INFO - Cleaning up... 10:19:09 INFO - Return code: 0 10:19:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:09 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 10:19:09 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 10:19:09 INFO - Using env: {'DISPLAY': ':0', 10:19:09 INFO - 'HOME': '/home/cltbld', 10:19:09 INFO - 'LANG': 'en_US.UTF-8', 10:19:09 INFO - 'LANGUAGE': 'en_US:en', 10:19:09 INFO - 'LOGNAME': 'cltbld', 10:19:09 INFO - 'MAIL': '/var/mail/cltbld', 10:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:09 INFO - 'MOZ_NO_REMOTE': '1', 10:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:09 INFO - 'NO_EM_RESTART': '1', 10:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:09 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:09 INFO - 'SHELL': '/bin/bash', 10:19:09 INFO - 'SHLVL': '1', 10:19:09 INFO - 'TERM': 'linux', 10:19:09 INFO - 'TMOUT': '86400', 10:19:09 INFO - 'USER': 'cltbld', 10:19:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:09 INFO - '_': '/tools/buildbot/bin/python'} 10:19:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:09 INFO - Downloading/unpacking psutil>=0.7.1 10:19:09 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 10:19:09 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 10:19:09 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 10:19:09 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 10:19:09 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 10:19:09 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 10:19:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:11 INFO - Installing collected packages: psutil 10:19:11 INFO - Running setup.py install for psutil 10:19:11 INFO - building 'psutil._psutil_linux' extension 10:19:11 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 10:19:11 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 10:19:11 INFO - building 'psutil._psutil_posix' extension 10:19:11 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 10:19:11 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 10:19:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:12 INFO - Successfully installed psutil 10:19:12 INFO - Cleaning up... 10:19:12 INFO - Return code: 0 10:19:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:19:12 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')]} 10:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 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')]} 10:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:12 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 10:19:12 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 10:19:12 INFO - Using env: {'DISPLAY': ':0', 10:19:12 INFO - 'HOME': '/home/cltbld', 10:19:12 INFO - 'LANG': 'en_US.UTF-8', 10:19:12 INFO - 'LANGUAGE': 'en_US:en', 10:19:12 INFO - 'LOGNAME': 'cltbld', 10:19:12 INFO - 'MAIL': '/var/mail/cltbld', 10:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:12 INFO - 'MOZ_NO_REMOTE': '1', 10:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:12 INFO - 'NO_EM_RESTART': '1', 10:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:12 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:12 INFO - 'SHELL': '/bin/bash', 10:19:12 INFO - 'SHLVL': '1', 10:19:12 INFO - 'TERM': 'linux', 10:19:12 INFO - 'TMOUT': '86400', 10:19:12 INFO - 'USER': 'cltbld', 10:19:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:12 INFO - '_': '/tools/buildbot/bin/python'} 10:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:19:12 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 10:19:12 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 10:19:12 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 10:19:12 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 10:19:12 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 10:19:12 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 10:19:14 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:19:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:19:14 INFO - Installing collected packages: mozsystemmonitor 10:19:14 INFO - Running setup.py install for mozsystemmonitor 10:19:14 INFO - Successfully installed mozsystemmonitor 10:19:14 INFO - Cleaning up... 10:19:14 INFO - Return code: 0 10:19:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:19: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')]} 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:14 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 10:19:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:19:14 INFO - Using env: {'DISPLAY': ':0', 10:19:14 INFO - 'HOME': '/home/cltbld', 10:19:14 INFO - 'LANG': 'en_US.UTF-8', 10:19:14 INFO - 'LANGUAGE': 'en_US:en', 10:19:14 INFO - 'LOGNAME': 'cltbld', 10:19:14 INFO - 'MAIL': '/var/mail/cltbld', 10:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:14 INFO - 'MOZ_NO_REMOTE': '1', 10:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:14 INFO - 'NO_EM_RESTART': '1', 10:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:14 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:14 INFO - 'SHELL': '/bin/bash', 10:19:14 INFO - 'SHLVL': '1', 10:19:14 INFO - 'TERM': 'linux', 10:19:14 INFO - 'TMOUT': '86400', 10:19:14 INFO - 'USER': 'cltbld', 10:19:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:14 INFO - '_': '/tools/buildbot/bin/python'} 10:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:14 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:19:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:17 INFO - Downloading docopt-0.6.1.tar.gz 10:19:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:17 INFO - Running setup.py install for blobuploader 10:19:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:17 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:19:17 INFO - Running setup.py install for requests 10:19:17 INFO - Running setup.py install for docopt 10:19:17 INFO - Successfully installed blobuploader requests docopt 10:19:17 INFO - Cleaning up... 10:19:17 INFO - Return code: 0 10:19:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:17 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:17 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 10:19:17 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 10:19:17 INFO - Using env: {'DISPLAY': ':0', 10:19:17 INFO - 'HOME': '/home/cltbld', 10:19:17 INFO - 'LANG': 'en_US.UTF-8', 10:19:17 INFO - 'LANGUAGE': 'en_US:en', 10:19:17 INFO - 'LOGNAME': 'cltbld', 10:19:17 INFO - 'MAIL': '/var/mail/cltbld', 10:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:17 INFO - 'MOZ_NO_REMOTE': '1', 10:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:17 INFO - 'NO_EM_RESTART': '1', 10:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:17 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:17 INFO - 'SHELL': '/bin/bash', 10:19:17 INFO - 'SHLVL': '1', 10:19:17 INFO - 'TERM': 'linux', 10:19:17 INFO - 'TMOUT': '86400', 10:19:17 INFO - 'USER': 'cltbld', 10:19:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:17 INFO - '_': '/tools/buildbot/bin/python'} 10:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:17 INFO - Running setup.py (path:/tmp/pip-iafH7B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:17 INFO - Running setup.py (path:/tmp/pip-YwC1Pd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:18 INFO - Running setup.py (path:/tmp/pip-F6Jcxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:18 INFO - Running setup.py (path:/tmp/pip-Enjta4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:18 INFO - Running setup.py (path:/tmp/pip-xxIYi3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:18 INFO - Running setup.py (path:/tmp/pip-qdXwOq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:18 INFO - Running setup.py (path:/tmp/pip-sVt9ZI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:18 INFO - Running setup.py (path:/tmp/pip-4Xs6u1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:18 INFO - Running setup.py (path:/tmp/pip-cpGqXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:18 INFO - Running setup.py (path:/tmp/pip-TrxBu4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:18 INFO - Running setup.py (path:/tmp/pip-9NnoMu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:18 INFO - Running setup.py (path:/tmp/pip-KnMRIh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:18 INFO - Running setup.py (path:/tmp/pip-HGRNKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:18 INFO - Running setup.py (path:/tmp/pip-khW5xw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:18 INFO - Running setup.py (path:/tmp/pip-a9d505-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:19 INFO - Running setup.py (path:/tmp/pip-fbYFyC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:19 INFO - Running setup.py (path:/tmp/pip-DSIYRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:19 INFO - Running setup.py install for manifestparser 10:19:19 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Running setup.py install for mozcrash 10:19:19 INFO - Running setup.py install for mozdebug 10:19:19 INFO - Running setup.py install for mozdevice 10:19:19 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Running setup.py install for mozfile 10:19:19 INFO - Running setup.py install for mozhttpd 10:19:19 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Running setup.py install for mozinfo 10:19:19 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Running setup.py install for mozInstall 10:19:19 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:19:19 INFO - Running setup.py install for mozleak 10:19:20 INFO - Running setup.py install for mozlog 10:19:20 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Running setup.py install for moznetwork 10:19:20 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Running setup.py install for mozprocess 10:19:20 INFO - Running setup.py install for mozprofile 10:19:20 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Running setup.py install for mozrunner 10:19:20 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Running setup.py install for mozscreenshot 10:19:20 INFO - Running setup.py install for moztest 10:19:20 INFO - Running setup.py install for mozversion 10:19:20 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:19:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:20 INFO - Cleaning up... 10:19:20 INFO - Return code: 0 10:19:20 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:19:20 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')]} 10:19:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:20 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')]} 10:19:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:20 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:20 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 10:19:20 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 10:19:20 INFO - Using env: {'DISPLAY': ':0', 10:19:20 INFO - 'HOME': '/home/cltbld', 10:19:20 INFO - 'LANG': 'en_US.UTF-8', 10:19:20 INFO - 'LANGUAGE': 'en_US:en', 10:19:20 INFO - 'LOGNAME': 'cltbld', 10:19:20 INFO - 'MAIL': '/var/mail/cltbld', 10:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:20 INFO - 'MOZ_NO_REMOTE': '1', 10:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:20 INFO - 'NO_EM_RESTART': '1', 10:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:20 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:20 INFO - 'SHELL': '/bin/bash', 10:19:20 INFO - 'SHLVL': '1', 10:19:20 INFO - 'TERM': 'linux', 10:19:20 INFO - 'TMOUT': '86400', 10:19:20 INFO - 'USER': 'cltbld', 10:19:20 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:20 INFO - '_': '/tools/buildbot/bin/python'} 10:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:21 INFO - Running setup.py (path:/tmp/pip-DBnSrO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:21 INFO - Running setup.py (path:/tmp/pip-9SQogd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:21 INFO - Running setup.py (path:/tmp/pip-1zBGXY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:21 INFO - Running setup.py (path:/tmp/pip-LpDLUK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:21 INFO - Running setup.py (path:/tmp/pip-jDpSIU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:21 INFO - Running setup.py (path:/tmp/pip-46bSEo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:21 INFO - Running setup.py (path:/tmp/pip-7Qfvz4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:21 INFO - Running setup.py (path:/tmp/pip-KcEUey-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:21 INFO - Running setup.py (path:/tmp/pip-wdyduy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:21 INFO - Running setup.py (path:/tmp/pip-MBxffJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:21 INFO - Running setup.py (path:/tmp/pip-Hxb_cN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:21 INFO - Running setup.py (path:/tmp/pip-RqRHPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:22 INFO - Running setup.py (path:/tmp/pip-fSxrvc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:22 INFO - Running setup.py (path:/tmp/pip-mkkKhD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:22 INFO - Running setup.py (path:/tmp/pip-nVfB6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:22 INFO - Running setup.py (path:/tmp/pip-XGla5G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:22 INFO - Running setup.py (path:/tmp/pip-2KBOBE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:22 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 10:19:22 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 10:19:22 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 10:19:22 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 10:19:22 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 10:19:22 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 10:19:24 INFO - Downloading blessings-1.6.tar.gz 10:19:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:24 INFO - Installing collected packages: blessings 10:19:24 INFO - Running setup.py install for blessings 10:19:24 INFO - Successfully installed blessings 10:19:24 INFO - Cleaning up... 10:19:24 INFO - Return code: 0 10:19:24 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:19:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:19:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:19:24 INFO - Reading from file tmpfile_stdout 10:19:24 INFO - Current package versions: 10:19:24 INFO - argparse == 1.2.1 10:19:24 INFO - blessings == 1.6 10:19:24 INFO - blobuploader == 1.2.4 10:19:24 INFO - docopt == 0.6.1 10:19:24 INFO - manifestparser == 1.1 10:19:24 INFO - mozInstall == 1.12 10:19:24 INFO - mozcrash == 0.16 10:19:24 INFO - mozdebug == 0.1 10:19:24 INFO - mozdevice == 0.48 10:19:24 INFO - mozfile == 1.2 10:19:24 INFO - mozhttpd == 0.7 10:19:24 INFO - mozinfo == 0.9 10:19:24 INFO - mozleak == 0.1 10:19:24 INFO - mozlog == 3.1 10:19:24 INFO - moznetwork == 0.27 10:19:24 INFO - mozprocess == 0.22 10:19:24 INFO - mozprofile == 0.28 10:19:24 INFO - mozrunner == 6.11 10:19:24 INFO - mozscreenshot == 0.1 10:19:24 INFO - mozsystemmonitor == 0.0 10:19:24 INFO - moztest == 0.7 10:19:24 INFO - mozversion == 1.4 10:19:24 INFO - psutil == 3.1.1 10:19:24 INFO - requests == 1.2.3 10:19:24 INFO - wsgiref == 0.1.2 10:19:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:24 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 10:19:24 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 10:19:24 INFO - Using env: {'DISPLAY': ':0', 10:19:24 INFO - 'HOME': '/home/cltbld', 10:19:24 INFO - 'LANG': 'en_US.UTF-8', 10:19:24 INFO - 'LANGUAGE': 'en_US:en', 10:19:24 INFO - 'LOGNAME': 'cltbld', 10:19:24 INFO - 'MAIL': '/var/mail/cltbld', 10:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:24 INFO - 'MOZ_NO_REMOTE': '1', 10:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:24 INFO - 'NO_EM_RESTART': '1', 10:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:24 INFO - 'SHELL': '/bin/bash', 10:19:24 INFO - 'SHLVL': '1', 10:19:24 INFO - 'TERM': 'linux', 10:19:24 INFO - 'TMOUT': '86400', 10:19:24 INFO - 'USER': 'cltbld', 10:19:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:24 INFO - '_': '/tools/buildbot/bin/python'} 10:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 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)) 10:19:24 INFO - Cleaning up... 10:19:24 INFO - Return code: 0 10:19:24 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:24 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 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19:24 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 10:19:24 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 10:19:24 INFO - Using env: {'DISPLAY': ':0', 10:19:24 INFO - 'HOME': '/home/cltbld', 10:19:24 INFO - 'LANG': 'en_US.UTF-8', 10:19:24 INFO - 'LANGUAGE': 'en_US:en', 10:19:24 INFO - 'LOGNAME': 'cltbld', 10:19:24 INFO - 'MAIL': '/var/mail/cltbld', 10:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:24 INFO - 'MOZ_NO_REMOTE': '1', 10:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:24 INFO - 'NO_EM_RESTART': '1', 10:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:24 INFO - 'SHELL': '/bin/bash', 10:19:24 INFO - 'SHLVL': '1', 10:19:24 INFO - 'TERM': 'linux', 10:19:24 INFO - 'TMOUT': '86400', 10:19:24 INFO - 'USER': 'cltbld', 10:19:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:24 INFO - '_': '/tools/buildbot/bin/python'} 10:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:25 INFO - Downloading/unpacking jsonschema 10:19:25 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 10:19:25 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 10:19:25 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 10:19:25 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 10:19:25 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 10:19:25 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 10:19:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:26 INFO - Downloading/unpacking functools32 (from jsonschema) 10:19:26 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 10:19:26 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 10:19:26 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 10:19:26 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 10:19:26 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 10:19:26 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 10:19:27 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:27 INFO - warning: no files found matching '*.txt' 10:19:27 INFO - no previously-included directories found matching 'build' 10:19:27 INFO - no previously-included directories found matching 'dist' 10:19:27 INFO - no previously-included directories found matching '.git*' 10:19:27 INFO - Installing collected packages: jsonschema, functools32 10:19:27 INFO - Running setup.py install for functools32 10:19:27 INFO - warning: no files found matching '*.txt' 10:19:27 INFO - no previously-included directories found matching 'build' 10:19:27 INFO - no previously-included directories found matching 'dist' 10:19:27 INFO - no previously-included directories found matching '.git*' 10:19:27 INFO - Successfully installed jsonschema functools32 10:19:27 INFO - Cleaning up... 10:19:27 INFO - Return code: 0 10:19:27 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:19: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')]} 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5600dc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24c4670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, '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': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', '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 10:19: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', 'flake8'] in /builds/slave/test-pgo/build 10:19: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 flake8 10:19:27 INFO - Using env: {'DISPLAY': ':0', 10:19:27 INFO - 'HOME': '/home/cltbld', 10:19:27 INFO - 'LANG': 'en_US.UTF-8', 10:19:27 INFO - 'LANGUAGE': 'en_US:en', 10:19:27 INFO - 'LOGNAME': 'cltbld', 10:19:27 INFO - 'MAIL': '/var/mail/cltbld', 10:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:27 INFO - 'MOZ_NO_REMOTE': '1', 10:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:27 INFO - 'NO_EM_RESTART': '1', 10:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:27 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:27 INFO - 'SHELL': '/bin/bash', 10:19:27 INFO - 'SHLVL': '1', 10:19:27 INFO - 'TERM': 'linux', 10:19:27 INFO - 'TMOUT': '86400', 10:19:27 INFO - 'USER': 'cltbld', 10:19:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:27 INFO - '_': '/tools/buildbot/bin/python'} 10:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:27 INFO - Downloading/unpacking flake8 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:19:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:19:29 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:29 INFO - no previously-included directories found matching 'docs/_build' 10:19:30 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:19:30 INFO - Running setup.py install for pep8 10:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:19:30 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:19:30 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:19:30 INFO - no previously-included directories found matching 'docs/_build' 10:19:30 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:19:30 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:19:30 INFO - Cleaning up... 10:19:30 INFO - Return code: 0 10:19:30 INFO - Running post-action listener: _resource_record_post_action 10:19:30 INFO - Running post-action listener: _start_resource_monitoring 10:19:30 INFO - Starting resource monitoring. 10:19:30 INFO - ##### 10:19:30 INFO - ##### Running install step. 10:19:30 INFO - ##### 10:19:30 INFO - Running pre-action listener: _resource_record_pre_action 10:19:30 INFO - Running main action method: install 10:19:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:19:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:19:30 INFO - Reading from file tmpfile_stdout 10:19:30 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:30 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:19:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:19:30 INFO - Reading from file tmpfile_stdout 10:19:30 INFO - Output received: 10:19:30 INFO - Usage: mozinstall [options] installer 10:19:30 INFO - Options: 10:19:30 INFO - -h, --help show this help message and exit 10:19:30 INFO - -d DEST, --destination=DEST 10:19:30 INFO - Directory to install application into. [default: 10:19:30 INFO - "/builds/slave/test-pgo"] 10:19:30 INFO - --app=APP Application being installed. [default: firefox] 10:19:30 INFO - mkdir: /builds/slave/test-pgo/build/application 10:19:30 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'] 10:19:30 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 10:19:46 INFO - Reading from file tmpfile_stdout 10:19:46 INFO - Output received: 10:19:46 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:19:46 INFO - Running post-action listener: _resource_record_post_action 10:19:46 INFO - ##### 10:19:46 INFO - ##### Running run-tests step. 10:19:46 INFO - ##### 10:19:46 INFO - Running pre-action listener: _resource_record_pre_action 10:19:46 INFO - Running main action method: run_tests 10:19:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:19:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:19:46 INFO - Python 2.7.3 10:19:46 INFO - Return code: 0 10:19:46 INFO - grabbing minidump binary from tooltool 10:19:46 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')]} 10:19:46 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 0x25538c0>, '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 0x25547c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2554c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:19:46 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 10:19:46 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 10:19:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:46 INFO - Return code: 0 10:19:46 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:19:46 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:19:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:19:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:19:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:19:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:19:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:19:47 INFO - Return code: 0 10:19:47 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:19:47 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:19:47 INFO - Using env: {'DISPLAY': ':0', 10:19:47 INFO - 'HOME': '/home/cltbld', 10:19:47 INFO - 'LANG': 'en_US.UTF-8', 10:19:47 INFO - 'LANGUAGE': 'en_US:en', 10:19:47 INFO - 'LOGNAME': 'cltbld', 10:19:47 INFO - 'MAIL': '/var/mail/cltbld', 10:19:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:19:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:47 INFO - 'MOZ_NO_REMOTE': '1', 10:19:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:47 INFO - 'NO_EM_RESTART': '1', 10:19:47 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:19:47 INFO - 'PWD': '/builds/slave/test-pgo', 10:19:47 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:19:47 INFO - 'SHELL': '/bin/bash', 10:19:47 INFO - 'SHLVL': '1', 10:19:47 INFO - 'TERM': 'linux', 10:19:47 INFO - 'TMOUT': '86400', 10:19:47 INFO - 'USER': 'cltbld', 10:19:47 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1455295782.602179-980805405', 10:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:47 INFO - '_': '/tools/buildbot/bin/python'} 10:19:47 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:19:48 INFO - mozversion application_buildid: 20160212073253 10:19:48 INFO - mozversion application_changeset: 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 10:19:48 INFO - mozversion application_display_name: Nightly 10:19:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:48 INFO - mozversion application_name: Firefox 10:19:48 INFO - mozversion application_remotingname: firefox 10:19:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:19:48 INFO - mozversion application_vendor: Mozilla 10:19:48 INFO - mozversion application_version: 47.0a1 10:19:48 INFO - mozversion platform_buildid: 20160212073253 10:19:48 INFO - mozversion platform_changeset: 218d16a9ddcc3699be2a19bcab7d5f6b7f8e7515 10:19:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:19:48 INFO - mozversion platform_version: 47.0a1 10:19:48 INFO - using testdate: 1455301188 10:19:48 INFO - actual date: 1455301188 10:19:48 INFO - starting webserver on 'localhost:48978' 10:19:48 INFO - SUITE-START | Running 2 tests 10:19:48 INFO - TEST-START | dromaeo_css 10:19:48 INFO - operating with platform_type : linux_ 10:19:48 INFO - Initialising browser for dromaeo_css test... 10:19:48 INFO - TEST-INFO | started process 5730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCPvyJx/profile http://localhost:48978/getInfo.html) 10:19:52 INFO - PROCESS | 5730 | __metrics Screen width/height:1600/1200 10:19:52 INFO - PROCESS | 5730 | colorDepth:24 10:19:52 INFO - PROCESS | 5730 | Browser inner width/height: 1024/697 10:19:52 INFO - PROCESS | 5730 | __metrics 10:19:52 INFO - PROCESS | 5730 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:19:53 INFO - TEST-INFO | 5730: exit 0 10:19:53 INFO - Browser initialized. 10:19:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:53 INFO - TEST-INFO | started process 5823 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCPvyJx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:05 INFO - PROCESS | 5823 | RSS: Main: 153223168 10:20:05 INFO - PROCESS | 5823 | 10:20:56 INFO - PROCESS | 5823 | 1455301256934 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] 10:23:05 INFO - PROCESS | 5823 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48978/tests/dromaeo/cssquery-ext.html) 10:23:06 INFO - PROCESS | 5823 | RSS: Main: 241364992 10:23:06 INFO - PROCESS | 5823 | 10:26:08 INFO - PROCESS | 5823 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-ext.html (next: http://localhost:48978/tests/dromaeo/cssquery-jquery.html) 10:26:09 INFO - PROCESS | 5823 | RSS: Main: 240369664 10:26:09 INFO - PROCESS | 5823 | 10:29:11 INFO - PROCESS | 5823 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48978/tests/dromaeo/cssquery-mootools.html) 10:29:11 INFO - PROCESS | 5823 | RSS: Main: 238186496 10:29:11 INFO - PROCESS | 5823 | 10:32:13 INFO - PROCESS | 5823 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48978/tests/dromaeo/cssquery-prototype.html) 10:32:14 INFO - PROCESS | 5823 | RSS: Main: 220864512 10:32:14 INFO - PROCESS | 5823 | 10:35:16 INFO - PROCESS | 5823 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48978/tests/dromaeo/cssquery-yui.html) 10:35:17 INFO - PROCESS | 5823 | RSS: Main: 224137216 10:35:17 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | Cycle 1(1): loaded http://localhost:48978/tests/dromaeo/cssquery-yui.html (next: http://localhost:48978/tests/dromaeo/cssquery-dojo.html) 10:38:20 INFO - PROCESS | 5823 | RSS: Main: 279859200 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | __start_tp_report 10:38:20 INFO - PROCESS | 5823 | _x_x_mozilla_page_load 10:38:20 INFO - PROCESS | 5823 | _x_x_mozilla_page_load_details 10:38:20 INFO - PROCESS | 5823 | |i|pagename|runs| 10:38:20 INFO - PROCESS | 5823 | |0;dojo.html;3130.843457827109;3151.763617728671;3177.65045844957;3180.2208458927566;3212.469942459495;5130.71781052042;5142.331496905406;5194.8701282467955;5200.947990520093;5231.058409486291;5213.452587478308;5214.348206474191;5237;5239.423663397033;5239.580833533318;4769.761511924398;4777.832775852846;4789.2097803862325;4815.205491093965;4951.702897826142;4747.8575642730775;4892.6575139740235;4900.191468407708;4927;4971.900561988758;4738.384010078685;4773.260144677563;4816.831410900637;4822.132016237076;4841.588464980481;4774.474807771142;4798.1843086675;4799.832005879777;4800.903981920342;4843.564079232886;4747.952520474785;4793.952060479385;4808.61531077513;4818.807247710088;4871.342368780205;5046.6719663221775;5049.293098966147;5075.847724568269;5103.260027296058;5111.4121875984365;5538.6122971392015;5553.194786755897;5573.303337082864;5576.972115139439;5577.8047768327915;5549.889002219973;5576.191452239403;5582.888342233173;5586.190002449622;5588.385277619459;5085.262636917663;5198.818041368534;5250.579953603703;5329.813456529003;5379.085555455543;5733.885322293614;5759.136129580596;5770.596058275964;5773.018586840247;5780.71096445176;5470.124780035255;5536.861578460571;5554.50009499147;5558.527525160326;5560.916586251209;5588.21764952907;5594.049011668027;5633.0987042073075;5633.126865335879;5671.688057156896;5608.242887210175;5617.9438205618235;5635.3519345275;5638.943610563924;5644.8024319148635;5513.365962914236;5594.86012849682;5613;5653.378128405872;5665.886682266414;4364.869053928387;4407.338899165151;4411.1618792429335;4432.911341773211;4445.599896009375;3915.3735402335487;3930.0567863713077;3931.4299426583557;3941.901452463654;3965.960340396559;5194.92207616886;5258.290130832289;5269.894602107936;5292.311999440049;5332.653377530448;5663.263775709132;5680.11958146488;5680.233168522197;5686.829395118153;5739.942600574024;5198.974005130026;5246.632735708464;5253.737313134328;5270.868228294324;5323.334583177103;4730.219513780187;4807.927881081787;4859.1496488114435;4862.80548778052;4868.805247790048;5779.075347944393;5784.768609255582;5797.188393624896;5809.883802324014;5823.388544202882;5549.250851135206;5551.500364967011;5562.805301814417;5568.610197286313;5574.665520068809;5714.200011998407;5778.971105144616;5811.128330750421;5831.708414579339;5833.912491312719;5622.100463925753;5634.183043458594;5639.069553523786;5643.661380317194;5651.717414129195;5681.403452637579;5699.544036477155;5721.656700597978;5726.112452569859;5730.426957304237;5425.674459532441;5436.673799572039;5482.917756233739;5517.36550296721;5521.5306698931045;5508.283923089973;5518.061929471919;5551.306086739158;5555.3611334697025;5557.305336832896;5285.233641122093;5447.809326673548;5474.562035037267;5476.835694929158;5519.972400137974;5432.59255555827;5487.64330318528;5513.779448822002;5548.195511650869;5562.944370556243;5398.8110416136815;5410.053240682943;5415.566754659539;5428.945710543002;5429.5656347492895 10:38:20 INFO - PROCESS | 5823 | |1;ext.html;512.6309057478616;518.823599976008;518.8650950752808;547.8822053258549;551.074195351809;28629.141125766233;28966.710332896666;35962.64037359629;36280.81859590705;36315.27369452609;39086.41370379447;39489.40765888514;39514.8024259879;39516.20967580654;39534.20931581366;8539.444936079166;8746.125387461267;8755.605997730117;8756.080611535792;8756.430831995931;8539.402241843074;8655;8672.913270867306;8682.652693892236;8685.739427817176;8893.066228046058;8986.191242788147;8989.190972812445;8991.55042247885;8992;8817.426867253607;8886.422382545114;8893.421927574687;8898.510581917992;8907.510086945216;8793.7801554961;8921.598528066188;8940.240079593177;8941.284697224206;8944.463332200088;40145;40746;40788.18423631541;41007.38488922668;41034.38448423276;3365.209175843699;3479.8434070466888;3514.964850351515;3567.0547304964207;3940.4813830841745;30427.391452170832;30523.694763052306;30559;30603.846980765175;32059.51910721341;3134.388794185135;3144.119646498984;3208.6630903755004;3264.7388208943225;3272.083816531375;265378;265477;269636;270840.64579677174;271959;50630.74684626553;51564.22653660198;51604.74197628988;51788.74105629448;58711.70644146752;54410.45589544054;54576.45423545793;54578.18132728012;54625;54698.72650636722;15643.687126257411;15646.139462329682;15773.132477713607;15842.52472425829;15863.20683965797;12186.939065304618;12257.816132758016;12263.75472490563;12281.324527151093;12288;17238.913805430893;18857.81142188588;19362.225510979686;19702;19782.208711651372;7324.597147156957;7392.112946446461;7425.591592462466;7463.888041679379;7515.887261690969;964.2671569607149;998.9350692205129;1006.2503434941016;1030.7938412317567;1093.8842380771728;26089;26615.600765988525;26938.86530567374;26951;27031.459370812474;1050.2333296693457;1063.9787204255872;1117.9776404471866;1145.5188820695328;1186.483879512415;12887.484500620058;13431.932840335736;13558.186508809504;13895.65260868466;14006.229657368738;316490;319190;320821;321024;322116;50493.74753126211;50712.74643626758;50977;51021.7448912753;51104.48895511072;1255.8116282557507;1276.0493432392927;1282.589571337163;1294.9805752913715;1340.3499302838115;22593.774062259166;23043.654345185172;23143.305700829;23217.535649287256;23250.651240231073;39340.213195735356;40592.59407406006;41612;42416.787916061454;44064.77967610142;219498;221148;221475;222001;278424;31199.37601247917;31286.217844554067;31593.684063159075;31697.20756981094;31706.04881853548;40421.797891011534;41239.793801030806;41275;41573.792131039154;42124.368134478624;34603.48094778631;38240;38509.4223586652;40558.79720601378;41403.58596413997;36532;37585;38104.237915240985;38149.4277585842;38461.73075288632;36423;36808;39577.80211098926;40577.1884562313;40660.3900941492;31796;33593.66406335905;33609.49585756167;34147.65852341445;34211.4868276981;25066.248012559652;25079;25107.24678259655;25412.491750165264;25438.872805635852 10:38:20 INFO - PROCESS | 5823 | |2;jquery.html;330.95088569235526;335.5386343777306;356.3034268006048;356.6647351489601;359.7823316893281;13585.456581736718;14148.929255353734;16213.675726485479;16425.34298628055;17234.224459899302;15395.69208615827;16099.55104040636;16920.576985575368;16973.32106715733;16983.320667173328;4773.546513081269;4955.479674634165;4957.256411538262;4967.0810899983435;5010.298558201855;3710.5547334319917;4905.068037072945;5266.420693723688;5475.178723191513;5497.697626630554;5131.358580177478;5392;5433.918491222635;5483.451654834525;5491.972540137293;5336.332958380202;5457;5465.836024919259;5469.56243500521;5482.533984611313;5255.973720131413;5282.154855223146;5286.867828304285;5399.7030163341;5411.621186516906;12231.204971676902;12409.75180496385;14604.926975365055;19900.004999749955;19914.20343186271;2094.8743075415523;2146.302451703187;2204.867707937529;2258.6612008198736;2648.589468632365;8887;8956.955215223947;9566.9521652392;9655;12653.430595623218;1519.3770554072778;1849.9537511562185;1852.4905650945964;1896.6111947050958;1898.4968983219458;56567.71716141393;57369.71315143439;58167;59053.45679259215;59250.40749592492;9754.853677194847;10025.949870250748;10176.898231017743;10204.336718113298;10308.278420510642;12407;12421.068419868365;12430.56493022758;12462;12502.624921252376;7486.887696684554;7503.512271702322;7638.427117966064;7715.344195743424;7718.922810771933;7451.813704657318;7458.813529661693;7467.514611550232;7469.626518674045;7522.511036782592;3605.2428989912414;3967.682585393162;4086.8160932758096;4227;4258.765767882796;1578.3134336563633;1617.846304601061;1633.8284480129653;1636.1164970915572;1640.270079814495;402.68389314388065;403.6004355687848;917.5595714057156;997.2221667099674;997.6558087459815;9634.373765705206;10201.081902628799;15489.535313940374;15715.842841571437;16985.91507042457;782.8708263136518;901.7069452427987;942.072059021863;962.6871266838306;1022.7749895023231;9206.723798285928;9348.95325523368;9349.859752103725;9369.765755856022;9557.713268601952;340862;380661;386943;389532;392427;55579.166312505346;73567.63216183885;73678.2632173682;76039.23960760322;76952.23047769451;463.99072018560116;477.88769639134773;1096.572336788653;1131.4851742457163;1134.65393055119;8042.638081286474;9279.304052195977;9654.420734755937;9813.803723925625;9911.306208565331;29173.85413073006;31987.680123198472;33508.49737253894;33824.66175338215;33901;37732.43401348927;38750.61249387583;40175;40493.59506404898;41586.792066039474;6799.660016999229;7024.578525288499;7028.9297107030325;7112;7121.9643901780155;11148.43585975214;11264.774704506028;11305.943470282597;11324.207305488866;11693.239939403911;9445.197158241352;9593.520323983634;9915.65295214664;10035.799284014425;10117.392956422638;9838.852417213604;10244.590216391261;10253.282270241012;10667.786644267226;10711.464426778473;9934.254930880357;9969.551370188214;10078.445685487368;10261.640842570474;10300.536475858755;6688.632125233159;6898.448124150156;7034.788956331318;7153.6423178839805;7195.208527062124;8550.187732165434;9154.359194856563;9346.626134954526;9515.286353523376;9630.229581633592 10:38:20 INFO - PROCESS | 5823 | |3;mootools.html;1315.7960516120004;1469.478335191007;1477.2466042318415;1668.591195157186;1845.6677797996356;7022.508424410287;7574.09110906692;7601.961990190048;7604.923950760491;7605.125410577785;7253.564786112837;7451.552906825595;7458.4033277337685;7464.066991626047;7473.588952607604;1977.3870100268891;2253.459169799253;2260.3445000949705;2278.908843646252;2286.3598192506042;2245.955080898381;2249.347689170139;2250.516139030108;2251.763564825694;2253.7408198057187;2189.244710574857;2238.597052530544;2239.6192647249927;2243.540074284776;2245.786650268222;2239.1603148819195;2247.4606094537357;2248.4378905273684;2305.1586171047616;2311.641695537194;2273.454370950976;2312.4450131968374;2316.6872472216205;2318.362450326157;2331.813454923602;7892.210778922119;7968.163342848975;7972.3622110231045;7974.082980457206;7981.640826162837;4653.395058642389;4778.665493415462;4810.7113573185725;4817.253325734517;4820.276958456225;2901.10065879578;2927.838968856712;2959.7040295970446;2972.1529364131334;3035.544668299751;837.5309826497181;860.1914200651368;875.369733791669;889.1983290232795;893.597880953567;11151.107911367071;11191.328520288727;11193.10455163585;11206.831897521544;11241.381724005176;4243.8090285937205;4253.787310634518;4320.308750599952;4327.156204540084;4331.242032644274;9493.572789224501;9507.524623768784;9514.143727064597;9514.714558563253;9525.904740952641;4878.487758785347;4880.438749543777;4882.658213924991;4885.926711099336;4894.045661096124;4365.2797288447055;4413.051193993243;4416.492103408085;4421.38100665907;4422.624076953431;3377.966220337765;3569.464580312922;3627.673509384168;3651.032476393758;3666.908327291839;1104.6465131158113;1109.6892869996414;1113.3653817324048;1138.9373584452935;1146.2549342927164;1068.5191663751343;1086.9728256793644;1249.188027781949;1277.1889849945167;1280.8462984441926;7424.554526728413;7467.7386291480625;7482.775516734507;7506.474546781673;7516.586587737727;1128.249713940237;1133.0270475664138;1133.1388145009853;1170.0697945133638;1175.5826681528106;5707.172459993278;5751.913721294184;5758.3090029196765;5758.827235182951;5758.856028599319;9468.289878259158;9615.51922403877;9730.902690973;9874.851877221847;9889.406635601887;9721;9735.610575576897;9735.853962190573;9742.46416447088;9752.707418777307;7419.258074192646;7476.439267054992;7486.288802563748;7590.848183036308;7635.770926872203;7085.468589855678;7111.53775004623;7122.465815063994;7129.25142860013;7133.85732285341;8370.414071015213;8400.579971001547;8744.300455963636;8804.383693141419;8827.07315731839;8858.557072146496;8858.955705221433;8865.955670221607;8951.507667078373;8953.776155596162;6592.736290548324;6708.429783468265;6711.697973591103;6728.899066514105;6730.293319201413;6692.866142677217;7375.520591161558;7581.734639287599;7582.090149182133;7610.124835643972;6996.755113571001;7187.712491500491;7204;7227.891581626174;7279.526830755984;7068.71725130989;7080.822979425556;7103.467239956921;7194.100737407824;7210.639468026473;7027.22700502934;7121.8575628486105;7143.464240182111;7165.3551180394015;7165.426765858614;6485;6519.119918810899;6529.542931994714;6531.183602049744;6531.706073226811;6403.743850246125;6453.225612926291;6454.967725161344;6457.3865482779065;6457.418832305115 10:38:20 INFO - PROCESS | 5823 | |4;prototype.html;324.12809542331144;324.7288514090734;326.626013214869;330.1416317574306;330.8659992702956;5741.397153298901;5757.971210143949;5783.334916484606;5834.045594725772;5883.0881213411885;5749.798757043504;5771.047777116782;5774.364819869811;5777.682227477487;5800.245968024151;4466.821327146927;4472.955270447303;4473.776311184444;4481.215787237221;4484.59638632523;4265.957340426603;4404.69167158299;4410.4266445362055;4475.753833539154;4478.171538265431;4335.046289816251;4337.219300525904;4339.761313127777;4343.956560434387;4347.347897815337;4212.515560710527;4357.172137293904;4357.891052723691;4365.628921541673;4373.2565463871215;3727.981360093182;3730.123420996064;3792.886213413602;3796.3925771876366;3805.2960202362374;5470.699111548864;5484.533814625722;5494.395616482184;5502.147167189092;5508.338999320107;4799.256115302133;4958.404991401055;5082.491750824925;5084.059449001909;5091.338126043591;6063.757449702007;6067.484263837579;6091.908621370683;6102.298235702907;6124.418180272867;4211.410402543646;4223.155368926227;4223.345381465878;4228.577142285778;4229.281022226198;6299.338569450233;6358.982562789977;6393.136926514908;6395.072714456378;6406.67966601668;4295;4391.890202744893;4396.318570621559;4399.692021558524;4414.558544145624;4449.377087207794;4468.463784345834;4473.060657261946;4494.505604383515;4495.415595972503;5166.560842328444;5173.068847607392;5173.896522069537;5178.145605974972;5181.119209734355;6060.303065147565;6204.13142160098;6205.162303089025;6206.937930620727;6212.968935155386;1585.69871724372;1600.5118438876254;1601.279424259088;1601.871850251977;1603.3426295218903;1059.7562560611102;1089.9400532970603;1092.4814507834117;1093.420487141816;1102.5644870276196;5862.70686465675;5878.471597384625;5878.559108066912;5882.441168089024;5883.852903677357;6335.651539165298;6337.112804207414;6341.524385671093;6343.111964324999;6365.2998170201245;5773.393793651606;5784.074548072288;5784.305883293948;5788.479036886701;5790.189373487715;3313.1717070732316;3419.7435192360176;3420.521127042216;3422.5208470814105;3423.7432192585657;6565.277819439858;6616.139901812733;6620.4041636252;6627.469802415795;6628.4697224221945;6455.193100862392;6468.256150542654;6475.611463312216;6479.870402591921;6485.059666348353;6312.968435157794;6381.329960354189;6512.34876512345;6662.0340050692375;6665.500087493458;6331.638697680021;6332.860085184711;6335.239771227298;6374.776882809079;6376.298607153117;6296.087067375113;6303.6532990685955;6306.747730090745;6307.779227727007;6320.1151838743535;6481.740730370921;6662.367075127855;6664.50016248793;6667.333266673294;6680.63256520896;4296.7851607420125;4332.653387729038;4333.674974376871;4334.9783251083545;4338.436003319548;6381.521385896169;6383;6394.712237949397;6398.520110991787;6414.807555773335;6029.60807547508;6169.475594574332;6182.1345011697495;6183.783567575293;6245.500359971101;6190.7523699051535;6201.224846894138;6201.596896201732;6205.100260462298;6215.223097112861;6120.265568131853;6124.265088189446;6124.38756124384;6128.1726966858905;6136;6056.36408177135;6190.102435146789;6197.845053873689;6205.317415084427;6262.561620686508;6047.123167140828;6048.90926636092;6058.303295121117;6068.757249709962;6116 10:38:20 INFO - PROCESS | 5823 | |5;yui.html;752.2928447259576;811.4563242627443;813.2802469814217;823.8681810910248;826.6894031182842;13406;13497.460101595936;13749.518766843163;13949.372278247478;13980.650483737887;13584;13675;13684.726305473885;13689.65775855604;13692.246926419042;682.9760958366459;698.1691786773748;827.1191181391798;827.8220182660742;844.2275318083946;840.5209030852417;841.154639587214;845.7547311279721;845.8519759042174;846.5301757524571;885.3802338363139;888.0187392930816;888.0409158109259;888.942218755782;889.1419779912384;705.8306006558415;862.4782006885838;874.2001069021837;874.4141425245101;875.5359659380539;637.0730586995957;642.5951650460227;643.0322364840931;643.1478291264094;644.5552568727563;13591.524296649668;13617.319134043259;13670.17978921258;13678.863211367858;13701.45194192231;12316;12475.251484910843;12493.500259989589;12629.101191396372;12677.492900283978;10361.274710770249;10386.948065259701;10399.79200415995;11022.724431889266;11159.330440173615;3562.661547153042;3621.27574485104;3624.1664417184197;3672.59601443841;3675.5956844747056;48580.271295930586;49145;49161.50838491605;49375;49379;9596.136347728738;9778.119969202806;9903.851442228372;10047.59809607622;10163.085322321027;17811.376601818873;17848.91075544614;17907.73138402925;17914.641707165785;17925.282988680567;7512.737054203186;7595.240475952361;7754.457187996786;7814.53112813233;7835.5690437026515;4234.1108367242605;4259.041715614024;4295.205387003414;4307.461567304087;4320.675949303752;3059.464593696094;3075.4156710224984;3102.751779857606;3105.767067469949;3118.8128712277335;556.0880156543273;562.2016736234557;576.19620629222;576.4178180038108;583.2679986616854;606.8391876152823;678.9355011273921;686.306830101601;698.0319651181704;727.0548287226584;8276.627551760184;8288.21261980111;8584.74245772628;8601.182887625666;8652.437591556529;582.4932308891292;671.6071098407486;698.2493819144339;710.1123595505618;718.396546900606;3868.3810590305416;4100.6719462443525;4152.854650087233;4206.348016057516;4321.10783300635;54187.18719219215;54251;54335.72832135814;55115.44884551103;55443.72278138583;46305.536944630796;46571.30143047857;46748.7662561685;46954;47646.52353476421;41778;42030.789846050575;42057.57942420598;42159;42314.57685423168;7370.48406611532;7613.961930190314;7725.072991240862;7817.140114587504;7864.921350786419;32795.180120496225;33272.33455330831;33903;33911.491327629614;34001;42343;42384.576154239294;42440.36339454973;42756.5724342765;42960.57039429565;11505.137114716597;11610.12924030718;11630.592929247436;11633.53465861356;11661.6501504955;11508.712282192677;11563.785802490618;11590.594329198437;12490.125691201529;12505.624831254712;10507.789844203226;10571.62999295021;10728.51721672511;11331.433428328715;11333.489992950503;10905.563777448813;10988.725281868017;11037.944810275898;11500.654980350602;11818.468168932246;7813.157178554595;10024.298299118991;10428.426436546062;10905.291156074829;11086.334819910831;8705.8694119587;8733.868991964999;9540.427574345562;9570.569324380558;9799.363041402286;8700.738977830675;8756.474611523328;8917.063708310794;9020.774480638036;9068.455892646462 10:38:20 INFO - PROCESS | 5823 | __end_tp_report 10:38:20 INFO - PROCESS | 5823 | __start_cc_report 10:38:20 INFO - PROCESS | 5823 | _x_x_mozilla_cycle_collect,714 10:38:20 INFO - PROCESS | 5823 | __end_cc_report 10:38:20 INFO - PROCESS | 5823 | __startTimestamp1455302300374__endTimestamp 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | ------- Summary: start ------- 10:38:20 INFO - PROCESS | 5823 | Number of tests: 6 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | [#0] dojo.html Cycles:165 Average:5230.44 Median:5432.59 stddev:563.14 (10.4%) stddev-sans-first:540.24 10:38:20 INFO - PROCESS | 5823 | Values: 3130.8 3151.8 3177.7 3180.2 3212.5 5130.7 5142.3 5194.9 5200.9 5231.1 5213.5 5214.3 5237.0 5239.4 5239.6 4769.8 4777.8 4789.2 4815.2 4951.7 4747.9 4892.7 4900.2 4927.0 4971.9 4738.4 4773.3 4816.8 4822.1 4841.6 4774.5 4798.2 4799.8 4800.9 4843.6 4748.0 4794.0 4808.6 4818.8 4871.3 5046.7 5049.3 5075.8 5103.3 5111.4 5538.6 5553.2 5573.3 5577.0 5577.8 5549.9 5576.2 5582.9 5586.2 5588.4 5085.3 5198.8 5250.6 5329.8 5379.1 5733.9 5759.1 5770.6 5773.0 5780.7 5470.1 5536.9 5554.5 5558.5 5560.9 5588.2 5594.0 5633.1 5633.1 5671.7 5608.2 5617.9 5635.4 5638.9 5644.8 5513.4 5594.9 5613.0 5653.4 5665.9 4364.9 4407.3 4411.2 4432.9 4445.6 3915.4 3930.1 3931.4 3941.9 3966.0 5194.9 5258.3 5269.9 5292.3 5332.7 5663.3 5680.1 5680.2 5686.8 5739.9 5199.0 5246.6 5253.7 5270.9 5323.3 4730.2 4807.9 4859.1 4862.8 4868.8 5779.1 5784.8 5797.2 5809.9 5823.4 5549.3 5551.5 5562.8 5568.6 5574.7 5714.2 5779.0 5811.1 5831.7 5833.9 5622.1 5634.2 5639.1 5643.7 5651.7 5681.4 5699.5 5721.7 5726.1 5730.4 5425.7 5436.7 5482.9 5517.4 5521.5 5508.3 5518.1 5551.3 5555.4 5557.3 5285.2 5447.8 5474.6 5476.8 5520.0 5432.6 5487.6 5513.8 5548.2 5562.9 5398.8 5410.1 5415.6 5428.9 5429.6 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | [#1] ext.html Cycles:180 Average:44016.49 Median:36121.73 stddev:72142.72 (199.7%) stddev-sans-first:72271.15 10:38:20 INFO - PROCESS | 5823 | Values: 512.6 518.8 518.9 547.9 551.1 28629.1 28966.7 35962.6 36280.8 36315.3 39086.4 39489.4 39514.8 39516.2 39534.2 8539.4 8746.1 8755.6 8756.1 8756.4 8539.4 8655.0 8672.9 8682.7 8685.7 8893.1 8986.2 8989.2 8991.6 8992.0 8817.4 8886.4 8893.4 8898.5 8907.5 8793.8 8921.6 8940.2 8941.3 8944.5 40145.0 40746.0 40788.2 41007.4 41034.4 3365.2 3479.8 3515.0 3567.1 3940.5 30427.4 30523.7 30559.0 30603.8 32059.5 3134.4 3144.1 3208.7 3264.7 3272.1 265378.0 265477.0 269636.0 270840.6 271959.0 50630.7 51564.2 51604.7 51788.7 58711.7 54410.5 54576.5 54578.2 54625.0 54698.7 15643.7 15646.1 15773.1 15842.5 15863.2 12186.9 12257.8 12263.8 12281.3 12288.0 17238.9 18857.8 19362.2 19702.0 19782.2 7324.6 7392.1 7425.6 7463.9 7515.9 964.3 998.9 1006.3 1030.8 1093.9 26089.0 26615.6 26938.9 26951.0 27031.5 1050.2 1064.0 1118.0 1145.5 1186.5 12887.5 13431.9 13558.2 13895.7 14006.2 316490.0 319190.0 320821.0 321024.0 322116.0 50493.7 50712.7 50977.0 51021.7 51104.5 1255.8 1276.0 1282.6 1295.0 1340.3 22593.8 23043.7 23143.3 23217.5 23250.7 39340.2 40592.6 41612.0 42416.8 44064.8 219498.0 221148.0 221475.0 222001.0 278424.0 31199.4 31286.2 31593.7 31697.2 31706.0 40421.8 41239.8 41275.0 41573.8 42124.4 34603.5 38240.0 38509.4 40558.8 41403.6 36532.0 37585.0 38104.2 38149.4 38461.7 36423.0 36808.0 39577.8 40577.2 40660.4 31796.0 33593.7 33609.5 34147.7 34211.5 25066.2 25079.0 25107.2 25412.5 25438.9 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | [#2] jquery.html Cycles:180 Average:22521.59 Median:470.94 stddev:62219.96 (13211.9%) stddev-sans-first:62372.20 10:38:20 INFO - PROCESS | 5823 | Values: 331.0 335.5 356.3 356.7 359.8 13585.5 14148.9 16213.7 16425.3 17234.2 15395.7 16099.6 16920.6 16973.3 16983.3 4773.5 4955.5 4957.3 4967.1 5010.3 3710.6 4905.1 5266.4 5475.2 5497.7 5131.4 5392.0 5433.9 5483.5 5492.0 5336.3 5457.0 5465.8 5469.6 5482.5 5256.0 5282.2 5286.9 5399.7 5411.6 12231.2 12409.8 14604.9 19900.0 19914.2 2094.9 2146.3 2204.9 2258.7 2648.6 8887.0 8957.0 9567.0 9655.0 12653.4 1519.4 1850.0 1852.5 1896.6 1898.5 56567.7 57369.7 58167.0 59053.5 59250.4 9754.9 10025.9 10176.9 10204.3 10308.3 12407.0 12421.1 12430.6 12462.0 12502.6 7486.9 7503.5 7638.4 7715.3 7718.9 7451.8 7458.8 7467.5 7469.6 7522.5 3605.2 3967.7 4086.8 4227.0 4258.8 1578.3 1617.8 1633.8 1636.1 1640.3 402.7 403.6 917.6 997.2 997.7 9634.4 10201.1 15489.5 15715.8 16985.9 782.9 901.7 942.1 962.7 1022.8 9206.7 9349.0 9349.9 9369.8 9557.7 340862.0 380661.0 386943.0 389532.0 392427.0 55579.2 73567.6 73678.3 76039.2 76952.2 464.0 477.9 1096.6 1131.5 1134.7 8042.6 9279.3 9654.4 9813.8 9911.3 29173.9 31987.7 33508.5 33824.7 33901.0 37732.4 38750.6 40175.0 40493.6 41586.8 6799.7 7024.6 7028.9 7112.0 7122.0 11148.4 11264.8 11305.9 11324.2 11693.2 9445.2 9593.5 9915.7 10035.8 10117.4 9838.9 10244.6 10253.3 10667.8 10711.5 9934.3 9969.6 10078.4 10261.6 10300.5 6688.6 6898.4 7034.8 7153.6 7195.2 8550.2 9154.4 9346.6 9515.3 9630.2 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | [#3] mootools.html Cycles:180 Average:5526.13 Median:6502.06 stddev:2920.02 (44.9%) stddev-sans-first:2911.06 10:38:20 INFO - PROCESS | 5823 | Values: 1315.8 1469.5 1477.2 1668.6 1845.7 7022.5 7574.1 7602.0 7604.9 7605.1 7253.6 7451.6 7458.4 7464.1 7473.6 1977.4 2253.5 2260.3 2278.9 2286.4 2246.0 2249.3 2250.5 2251.8 2253.7 2189.2 2238.6 2239.6 2243.5 2245.8 2239.2 2247.5 2248.4 2305.2 2311.6 2273.5 2312.4 2316.7 2318.4 2331.8 7892.2 7968.2 7972.4 7974.1 7981.6 4653.4 4778.7 4810.7 4817.3 4820.3 2901.1 2927.8 2959.7 2972.2 3035.5 837.5 860.2 875.4 889.2 893.6 11151.1 11191.3 11193.1 11206.8 11241.4 4243.8 4253.8 4320.3 4327.2 4331.2 9493.6 9507.5 9514.1 9514.7 9525.9 4878.5 4880.4 4882.7 4885.9 4894.0 4365.3 4413.1 4416.5 4421.4 4422.6 3378.0 3569.5 3627.7 3651.0 3666.9 1104.6 1109.7 1113.4 1138.9 1146.3 1068.5 1087.0 1249.2 1277.2 1280.8 7424.6 7467.7 7482.8 7506.5 7516.6 1128.2 1133.0 1133.1 1170.1 1175.6 5707.2 5751.9 5758.3 5758.8 5758.9 9468.3 9615.5 9730.9 9874.9 9889.4 9721.0 9735.6 9735.9 9742.5 9752.7 7419.3 7476.4 7486.3 7590.8 7635.8 7085.5 7111.5 7122.5 7129.3 7133.9 8370.4 8400.6 8744.3 8804.4 8827.1 8858.6 8859.0 8866.0 8951.5 8953.8 6592.7 6708.4 6711.7 6728.9 6730.3 6692.9 7375.5 7581.7 7582.1 7610.1 6996.8 7187.7 7204.0 7227.9 7279.5 7068.7 7080.8 7103.5 7194.1 7210.6 7027.2 7121.9 7143.5 7165.4 7165.4 6485.0 6519.1 6529.5 6531.2 6531.7 6403.7 6453.2 6455.0 6457.4 6457.4 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | [#4] prototype.html Cycles:180 Average:5140.32 Median:5789.33 stddev:1552.68 (26.8%) stddev-sans-first:1514.37 10:38:20 INFO - PROCESS | 5823 | Values: 324.1 324.7 326.6 330.1 330.9 5741.4 5758.0 5783.3 5834.0 5883.1 5749.8 5771.0 5774.4 5777.7 5800.2 4466.8 4473.0 4473.8 4481.2 4484.6 4266.0 4404.7 4410.4 4475.8 4478.2 4335.0 4337.2 4339.8 4344.0 4347.3 4212.5 4357.2 4357.9 4365.6 4373.3 3728.0 3730.1 3792.9 3796.4 3805.3 5470.7 5484.5 5494.4 5502.1 5508.3 4799.3 4958.4 5082.5 5084.1 5091.3 6063.8 6067.5 6091.9 6102.3 6124.4 4211.4 4223.2 4223.3 4228.6 4229.3 6299.3 6359.0 6393.1 6395.1 6406.7 4295.0 4391.9 4396.3 4399.7 4414.6 4449.4 4468.5 4473.1 4494.5 4495.4 5166.6 5173.1 5173.9 5178.1 5181.1 6060.3 6204.1 6205.2 6206.9 6213.0 1585.7 1600.5 1601.3 1601.9 1603.3 1059.8 1089.9 1092.5 1093.4 1102.6 5862.7 5878.5 5878.6 5882.4 5883.9 6335.7 6337.1 6341.5 6343.1 6365.3 5773.4 5784.1 5784.3 5788.5 5790.2 3313.2 3419.7 3420.5 3422.5 3423.7 6565.3 6616.1 6620.4 6627.5 6628.5 6455.2 6468.3 6475.6 6479.9 6485.1 6313.0 6381.3 6512.3 6662.0 6665.5 6331.6 6332.9 6335.2 6374.8 6376.3 6296.1 6303.7 6306.7 6307.8 6320.1 6481.7 6662.4 6664.5 6667.3 6680.6 4296.8 4332.7 4333.7 4335.0 4338.4 6381.5 6383.0 6394.7 6398.5 6414.8 6029.6 6169.5 6182.1 6183.8 6245.5 6190.8 6201.2 6201.6 6205.1 6215.2 6120.3 6124.3 6124.4 6128.2 6136.0 6056.4 6190.1 6197.8 6205.3 6262.6 6047.1 6048.9 6058.3 6068.8 6116.0 10:38:20 INFO - PROCESS | 5823 | 10:38:20 INFO - PROCESS | 5823 | [#5] yui.html Cycles:180 Average:13346.57 Median:25313.32 stddev:15123.63 (59.7%) stddev-sans-first:15136.48 10:38:20 INFO - PROCESS | 5823 | Values: 752.3 811.5 813.3 823.9 826.7 13406.0 13497.5 13749.5 13949.4 13980.7 13584.0 13675.0 13684.7 13689.7 13692.2 683.0 698.2 827.1 827.8 844.2 840.5 841.2 845.8 845.9 846.5 885.4 888.0 888.0 888.9 889.1 705.8 862.5 874.2 874.4 875.5 637.1 642.6 643.0 643.1 644.6 13591.5 13617.3 13670.2 13678.9 13701.5 12316.0 12475.3 12493.5 12629.1 12677.5 10361.3 10386.9 10399.8 11022.7 11159.3 3562.7 3621.3 3624.2 3672.6 3675.6 48580.3 49145.0 49161.5 49375.0 49379.0 9596.1 9778.1 9903.9 10047.6 10163.1 17811.4 17848.9 17907.7 17914.6 17925.3 7512.7 7595.2 7754.5 7814.5 7835.6 4234.1 4259.0 4295.2 4307.5 4320.7 3059.5 3075.4 3102.8 3105.8 3118.8 556.1 562.2 576.2 576.4 583.3 606.8 678.9 686.3 698.0 727.1 8276.6 8288.2 8584.7 8601.2 8652.4 582.5 671.6 698.2 710.1 718.4 3868.4 4100.7 4152.9 4206.3 4321.1 54187.2 54251.0 54335.7 55115.4 55443.7 46305.5 46571.3 46748.8 46954.0 47646.5 41778.0 42030.8 42057.6 42159.0 42314.6 7370.5 7614.0 7725.1 7817.1 7864.9 32795.2 33272.3 33903.0 33911.5 34001.0 42343.0 42384.6 42440.4 42756.6 42960.6 11505.1 11610.1 11630.6 11633.5 11661.7 11508.7 11563.8 11590.6 12490.1 12505.6 10507.8 10571.6 10728.5 11331.4 11333.5 10905.6 10988.7 11037.9 11500.7 11818.5 7813.2 10024.3 10428.4 10905.3 11086.3 8705.9 8733.9 9540.4 9570.6 9799.4 8700.7 8756.5 8917.1 9020.8 9068.5 10:38:20 INFO - PROCESS | 5823 | -------- Summary: end -------- 10:38:20 INFO - PROCESS | 5823 | 10:38:21 INFO - TEST-INFO | 5823: exit 0 10:38:21 INFO - TEST-OK | dromaeo_css | took 1112897ms 10:38:21 INFO - TEST-START | kraken 10:38:21 INFO - operating with platform_type : linux_ 10:38:21 INFO - Initialising browser for kraken test... 10:38:21 INFO - TEST-INFO | started process 6004 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQepuzZ/profile http://localhost:48978/getInfo.html) 10:38:25 INFO - PROCESS | 6004 | __metrics Screen width/height:1600/1200 10:38:25 INFO - PROCESS | 6004 | colorDepth:24 10:38:25 INFO - PROCESS | 6004 | Browser inner width/height: 1024/697 10:38:25 INFO - PROCESS | 6004 | __metrics 10:38:25 INFO - PROCESS | 6004 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:38:26 INFO - TEST-INFO | 6004: exit 0 10:38:26 INFO - Browser initialized. 10:38:26 INFO - Running cycle 1/1 for kraken test... 10:38:26 INFO - TEST-INFO | started process 6083 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQepuzZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:38 INFO - PROCESS | 6083 | RSS: Main: 153440256 10:38:38 INFO - PROCESS | 6083 | 10:38:40 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:41 INFO - PROCESS | 6083 | RSS: Main: 196194304 10:38:41 INFO - PROCESS | 6083 | 10:38:43 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-dft) 10:38:44 INFO - PROCESS | 6083 | RSS: Main: 186064896 10:38:44 INFO - PROCESS | 6083 | 10:38:47 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-fft) 10:38:47 INFO - PROCESS | 6083 | RSS: Main: 169598976 10:38:47 INFO - PROCESS | 6083 | 10:38:49 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48978/tests/kraken/driver.html?testName=audio-oscillator) 10:38:50 INFO - PROCESS | 6083 | RSS: Main: 172023808 10:38:50 INFO - PROCESS | 6083 | 10:38:52 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:53 INFO - PROCESS | 6083 | RSS: Main: 174063616 10:38:53 INFO - PROCESS | 6083 | 10:38:56 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:56 INFO - PROCESS | 6083 | RSS: Main: 174096384 10:38:56 INFO - PROCESS | 6083 | 10:39:00 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48978/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:00 INFO - PROCESS | 6083 | RSS: Main: 174129152 10:39:00 INFO - PROCESS | 6083 | 10:39:03 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48978/tests/kraken/driver.html?testName=json-parse-financial) 10:39:04 INFO - PROCESS | 6083 | RSS: Main: 174141440 10:39:04 INFO - PROCESS | 6083 | 10:39:05 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:06 INFO - PROCESS | 6083 | RSS: Main: 188485632 10:39:06 INFO - PROCESS | 6083 | 10:39:07 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:08 INFO - PROCESS | 6083 | RSS: Main: 185647104 10:39:08 INFO - PROCESS | 6083 | 10:39:10 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:11 INFO - PROCESS | 6083 | RSS: Main: 195375104 10:39:11 INFO - PROCESS | 6083 | 10:39:13 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:14 INFO - PROCESS | 6083 | RSS: Main: 200687616 10:39:14 INFO - PROCESS | 6083 | 10:39:16 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:17 INFO - PROCESS | 6083 | RSS: Main: 199143424 10:39:17 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | Cycle 1(1): loaded http://localhost:48978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48978/tests/kraken/driver.html?testName=ai-astar) 10:39:19 INFO - PROCESS | 6083 | RSS: Main: 262086656 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | __start_tp_report 10:39:19 INFO - PROCESS | 6083 | _x_x_mozilla_page_load 10:39:19 INFO - PROCESS | 6083 | _x_x_mozilla_page_load_details 10:39:19 INFO - PROCESS | 6083 | |i|pagename|runs| 10:39:19 INFO - PROCESS | 6083 | |0;ai-astar;111;111;108;113;112;111;101;109;110;112 10:39:19 INFO - PROCESS | 6083 | |1;audio-beat-detection;159;127;153;166;129;160;156;130;160;128 10:39:19 INFO - PROCESS | 6083 | |2;audio-dft;164;161;161;161;160;161;161;164;163;161 10:39:19 INFO - PROCESS | 6083 | |3;audio-fft;73;74;93;92;73;76;74;124;93;74 10:39:19 INFO - PROCESS | 6083 | |4;audio-oscillator;96;97;144;96;96;97;149;96;97;144 10:39:19 INFO - PROCESS | 6083 | |5;imaging-gaussian-blur;119;115;115;115;114;116;115;115;115;114 10:39:19 INFO - PROCESS | 6083 | |6;imaging-darkroom;145;145;146;145;145;145;146;145;145;146 10:39:19 INFO - PROCESS | 6083 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;95;96 10:39:19 INFO - PROCESS | 6083 | |8;json-parse-financial;58;57;57;57;57;57;56;66;55;54 10:39:19 INFO - PROCESS | 6083 | |9;json-stringify-tinderbox;68;68;69;68;69;70;69;69;68;69 10:39:19 INFO - PROCESS | 6083 | |10;stanford-crypto-aes;83;81;83;83;84;83;82;82;85;84 10:39:19 INFO - PROCESS | 6083 | |11;stanford-crypto-ccm;117;123;118;119;118;118;116;116;128;118 10:39:19 INFO - PROCESS | 6083 | |12;stanford-crypto-pbkdf2;150;139;162;153;155;145;150;152;147;145 10:39:19 INFO - PROCESS | 6083 | |13;stanford-crypto-sha256-iterative;71;72;71;69;69;72;70;70;69;69 10:39:19 INFO - PROCESS | 6083 | __end_tp_report 10:39:19 INFO - PROCESS | 6083 | __start_cc_report 10:39:19 INFO - PROCESS | 6083 | _x_x_mozilla_cycle_collect,1004 10:39:19 INFO - PROCESS | 6083 | __end_cc_report 10:39:19 INFO - PROCESS | 6083 | __startTimestamp1455302359380__endTimestamp 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | ------- Summary: start ------- 10:39:19 INFO - PROCESS | 6083 | Number of tests: 14 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.61 10:39:19 INFO - PROCESS | 6083 | Values: 111.0 111.0 108.0 113.0 112.0 111.0 101.0 109.0 110.0 112.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:157.50 stddev:16.10 (10.2%) stddev-sans-first:16.46 10:39:19 INFO - PROCESS | 6083 | Values: 159.0 127.0 153.0 166.0 129.0 160.0 156.0 130.0 160.0 128.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:1.42 (0.9%) stddev-sans-first:1.24 10:39:19 INFO - PROCESS | 6083 | Values: 164.0 161.0 161.0 161.0 160.0 161.0 161.0 164.0 163.0 161.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#3] audio-fft Cycles:10 Average:84.60 Median:75.00 stddev:16.43 (21.9%) stddev-sans-first:16.88 10:39:19 INFO - PROCESS | 6083 | Values: 73.0 74.0 93.0 92.0 73.0 76.0 74.0 124.0 93.0 74.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#4] audio-oscillator Cycles:10 Average:111.20 Median:96.00 stddev:23.83 (24.8%) stddev-sans-first:24.63 10:39:19 INFO - PROCESS | 6083 | Values: 96.0 97.0 144.0 96.0 96.0 97.0 149.0 96.0 97.0 144.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 10:39:19 INFO - PROCESS | 6083 | Values: 119.0 115.0 115.0 115.0 114.0 116.0 115.0 115.0 115.0 114.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 10:39:19 INFO - PROCESS | 6083 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:39:19 INFO - PROCESS | 6083 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:3.24 (5.7%) stddev-sans-first:3.43 10:39:19 INFO - PROCESS | 6083 | Values: 58.0 57.0 57.0 57.0 57.0 57.0 56.0 66.0 55.0 54.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 10:39:19 INFO - PROCESS | 6083 | Values: 68.0 68.0 69.0 68.0 69.0 70.0 69.0 69.0 68.0 69.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:1.15 (1.4%) stddev-sans-first:1.22 10:39:19 INFO - PROCESS | 6083 | Values: 83.0 81.0 83.0 83.0 84.0 83.0 82.0 82.0 85.0 84.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:118.00 stddev:3.70 (3.1%) stddev-sans-first:3.84 10:39:19 INFO - PROCESS | 6083 | Values: 117.0 123.0 118.0 119.0 118.0 118.0 116.0 116.0 128.0 118.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:151.00 stddev:6.34 (4.2%) stddev-sans-first:6.72 10:39:19 INFO - PROCESS | 6083 | Values: 150.0 139.0 162.0 153.0 155.0 145.0 150.0 152.0 147.0 145.0 10:39:19 INFO - PROCESS | 6083 | 10:39:19 INFO - PROCESS | 6083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.50 stddev:1.23 (1.7%) stddev-sans-first:1.27 10:39:19 INFO - PROCESS | 6083 | Values: 71.0 72.0 71.0 69.0 69.0 72.0 70.0 70.0 69.0 69.0 10:39:19 INFO - PROCESS | 6083 | -------- Summary: end -------- 10:39:19 INFO - PROCESS | 6083 | 10:39:20 INFO - TEST-INFO | 6083: exit 0 10:39:20 INFO - TEST-OK | kraken | took 59288ms 10:39:20 INFO - SUITE-END | took 1172s 10:39:20 INFO - Completed test suite (00:19:32) 10:39:20 INFO - Working with test: dromaeo_css 10:39:20 INFO - Generating results file: dromaeo_css 10:39:20 INFO - Working with test: kraken 10:39:20 INFO - Generating results file: kraken 10:39:20 INFO - javascript benchmark 10:39:20 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:39:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,35]] 10:39:20 INFO - process_Request line: dromaeo_css 6736.40 graph.html#tests=[[72,1,35]] 10:39:20 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:39:20 INFO - process_Request line: kraken 1518.80 graph.html#tests=[[232,1,35]] 10:39:20 INFO - RETURN: dromaeo_css: 6736.40 10:39:20 INFO - RETURN: kraken: 1518.80 10:39:20 INFO - javascript benchmark 10:39:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3130.843457827109, 3151.763617728671, 3177.65045844957, 3180.2208458927566, 3212.469942459495, 5130.71781052042, 5142.331496905406, 5194.8701282467955, 5200.947990520093, 5231.058409486291, 5213.452587478308, 5214.348206474191, 5237.0, 5239.423663397033, 5239.580833533318, 4769.761511924398, 4777.832775852846, 4789.2097803862325, 4815.205491093965, 4951.702897826142, 4747.8575642730775, 4892.6575139740235, 4900.191468407708, 4927.0, 4971.900561988758, 4738.384010078685, 4773.260144677563, 4816.831410900637, 4822.132016237076, 4841.588464980481, 4774.474807771142, 4798.1843086675, 4799.832005879777, 4800.903981920342, 4843.564079232886, 4747.952520474785, 4793.952060479385, 4808.61531077513, 4818.807247710088, 4871.342368780205, 5046.6719663221775, 5049.293098966147, 5075.847724568269, 5103.260027296058, 5111.4121875984365, 5538.6122971392015, 5553.194786755897, 5573.303337082864, 5576.972115139439, 5577.8047768327915, 5549.889002219973, 5576.191452239403, 5582.888342233173, 5586.190002449622, 5588.385277619459, 5085.262636917663, 5198.818041368534, 5250.579953603703, 5329.813456529003, 5379.085555455543, 5733.885322293614, 5759.136129580596, 5770.596058275964, 5773.018586840247, 5780.71096445176, 5470.124780035255, 5536.861578460571, 5554.50009499147, 5558.527525160326, 5560.916586251209, 5588.21764952907, 5594.049011668027, 5633.0987042073075, 5633.126865335879, 5671.688057156896, 5608.242887210175, 5617.9438205618235, 5635.3519345275, 5638.943610563924, 5644.8024319148635, 5513.365962914236, 5594.86012849682, 5613.0, 5653.378128405872, 5665.886682266414, 4364.869053928387, 4407.338899165151, 4411.1618792429335, 4432.911341773211, 4445.599896009375, 3915.3735402335487, 3930.0567863713077, 3931.4299426583557, 3941.901452463654, 3965.960340396559, 5194.92207616886, 5258.290130832289, 5269.894602107936, 5292.311999440049, 5332.653377530448, 5663.263775709132, 5680.11958146488, 5680.233168522197, 5686.829395118153, 5739.942600574024, 5198.974005130026, 5246.632735708464, 5253.737313134328, 5270.868228294324, 5323.334583177103, 4730.219513780187, 4807.927881081787, 4859.1496488114435, 4862.80548778052, 4868.805247790048, 5779.075347944393, 5784.768609255582, 5797.188393624896, 5809.883802324014, 5823.388544202882, 5549.250851135206, 5551.500364967011, 5562.805301814417, 5568.610197286313, 5574.665520068809, 5714.200011998407, 5778.971105144616, 5811.128330750421, 5831.708414579339, 5833.912491312719, 5622.100463925753, 5634.183043458594, 5639.069553523786, 5643.661380317194, 5651.717414129195, 5681.403452637579, 5699.544036477155, 5721.656700597978, 5726.112452569859, 5730.426957304237, 5425.674459532441, 5436.673799572039, 5482.917756233739, 5517.36550296721, 5521.5306698931045, 5508.283923089973, 5518.061929471919, 5551.306086739158, 5555.3611334697025, 5557.305336832896, 5285.233641122093, 5447.809326673548, 5474.562035037267, 5476.835694929158, 5519.972400137974, 5432.59255555827, 5487.64330318528, 5513.779448822002, 5548.195511650869, 5562.944370556243, 5398.8110416136815, 5410.053240682943, 5415.566754659539, 5428.945710543002, 5429.5656347492895], "unit": "score", "name": "dojo.html", "value": 5195.006806156801}, {"lowerIsBetter": false, "replicates": [512.6309057478616, 518.823599976008, 518.8650950752808, 547.8822053258549, 551.074195351809, 28629.141125766233, 28966.710332896666, 35962.64037359629, 36280.81859590705, 36315.27369452609, 39086.41370379447, 39489.40765888514, 39514.8024259879, 39516.20967580654, 39534.20931581366, 8539.444936079166, 8746.125387461267, 8755.605997730117, 8756.080611535792, 8756.430831995931, 8539.402241843074, 8655.0, 8672.913270867306, 8682.652693892236, 8685.739427817176, 8893.066228046058, 8986.191242788147, 8989.190972812445, 8991.55042247885, 8992.0, 8817.426867253607, 8886.422382545114, 8893.421927574687, 8898.510581917992, 8907.510086945216, 8793.7801554961, 8921.598528066188, 8940.240079593177, 8941.284697224206, 8944.463332200088, 40145.0, 40746.0, 40788.18423631541, 41007.38488922668, 41034.38448423276, 3365.209175843699, 3479.8434070466888, 3514.964850351515, 3567.0547304964207, 3940.4813830841745, 30427.391452170832, 30523.694763052306, 30559.0, 30603.846980765175, 32059.51910721341, 3134.388794185135, 3144.119646498984, 3208.6630903755004, 3264.7388208943225, 3272.083816531375, 265378.0, 265477.0, 269636.0, 270840.64579677174, 271959.0, 50630.74684626553, 51564.22653660198, 51604.74197628988, 51788.74105629448, 58711.70644146752, 54410.45589544054, 54576.45423545793, 54578.18132728012, 54625.0, 54698.72650636722, 15643.687126257411, 15646.139462329682, 15773.132477713607, 15842.52472425829, 15863.20683965797, 12186.939065304618, 12257.816132758016, 12263.75472490563, 12281.324527151093, 12288.0, 17238.913805430893, 18857.81142188588, 19362.225510979686, 19702.0, 19782.208711651372, 7324.597147156957, 7392.112946446461, 7425.591592462466, 7463.888041679379, 7515.887261690969, 964.2671569607149, 998.9350692205129, 1006.2503434941016, 1030.7938412317567, 1093.8842380771728, 26089.0, 26615.600765988525, 26938.86530567374, 26951.0, 27031.459370812474, 1050.2333296693457, 1063.9787204255872, 1117.9776404471866, 1145.5188820695328, 1186.483879512415, 12887.484500620058, 13431.932840335736, 13558.186508809504, 13895.65260868466, 14006.229657368738, 316490.0, 319190.0, 320821.0, 321024.0, 322116.0, 50493.74753126211, 50712.74643626758, 50977.0, 51021.7448912753, 51104.48895511072, 1255.8116282557507, 1276.0493432392927, 1282.589571337163, 1294.9805752913715, 1340.3499302838115, 22593.774062259166, 23043.654345185172, 23143.305700829, 23217.535649287256, 23250.651240231073, 39340.213195735356, 40592.59407406006, 41612.0, 42416.787916061454, 44064.77967610142, 219498.0, 221148.0, 221475.0, 222001.0, 278424.0, 31199.37601247917, 31286.217844554067, 31593.684063159075, 31697.20756981094, 31706.04881853548, 40421.797891011534, 41239.793801030806, 41275.0, 41573.792131039154, 42124.368134478624, 34603.48094778631, 38240.0, 38509.4223586652, 40558.79720601378, 41403.58596413997, 36532.0, 37585.0, 38104.237915240985, 38149.4277585842, 38461.73075288632, 36423.0, 36808.0, 39577.80211098926, 40577.1884562313, 40660.3900941492, 31796.0, 33593.66406335905, 33609.49585756167, 34147.65852341445, 34211.4868276981, 25066.248012559652, 25079.0, 25107.24678259655, 25412.491750165264, 25438.872805635852], "unit": "score", "name": "ext.html", "value": 17933.36017134498}, {"lowerIsBetter": false, "replicates": [330.95088569235526, 335.5386343777306, 356.3034268006048, 356.6647351489601, 359.7823316893281, 13585.456581736718, 14148.929255353734, 16213.675726485479, 16425.34298628055, 17234.224459899302, 15395.69208615827, 16099.55104040636, 16920.576985575368, 16973.32106715733, 16983.320667173328, 4773.546513081269, 4955.479674634165, 4957.256411538262, 4967.0810899983435, 5010.298558201855, 3710.5547334319917, 4905.068037072945, 5266.420693723688, 5475.178723191513, 5497.697626630554, 5131.358580177478, 5392.0, 5433.918491222635, 5483.451654834525, 5491.972540137293, 5336.332958380202, 5457.0, 5465.836024919259, 5469.56243500521, 5482.533984611313, 5255.973720131413, 5282.154855223146, 5286.867828304285, 5399.7030163341, 5411.621186516906, 12231.204971676902, 12409.75180496385, 14604.926975365055, 19900.004999749955, 19914.20343186271, 2094.8743075415523, 2146.302451703187, 2204.867707937529, 2258.6612008198736, 2648.589468632365, 8887.0, 8956.955215223947, 9566.9521652392, 9655.0, 12653.430595623218, 1519.3770554072778, 1849.9537511562185, 1852.4905650945964, 1896.6111947050958, 1898.4968983219458, 56567.71716141393, 57369.71315143439, 58167.0, 59053.45679259215, 59250.40749592492, 9754.853677194847, 10025.949870250748, 10176.898231017743, 10204.336718113298, 10308.278420510642, 12407.0, 12421.068419868365, 12430.56493022758, 12462.0, 12502.624921252376, 7486.887696684554, 7503.512271702322, 7638.427117966064, 7715.344195743424, 7718.922810771933, 7451.813704657318, 7458.813529661693, 7467.514611550232, 7469.626518674045, 7522.511036782592, 3605.2428989912414, 3967.682585393162, 4086.8160932758096, 4227.0, 4258.765767882796, 1578.3134336563633, 1617.846304601061, 1633.8284480129653, 1636.1164970915572, 1640.270079814495, 402.68389314388065, 403.6004355687848, 917.5595714057156, 997.2221667099674, 997.6558087459815, 9634.373765705206, 10201.081902628799, 15489.535313940374, 15715.842841571437, 16985.91507042457, 782.8708263136518, 901.7069452427987, 942.072059021863, 962.6871266838306, 1022.7749895023231, 9206.723798285928, 9348.95325523368, 9349.859752103725, 9369.765755856022, 9557.713268601952, 340862.0, 380661.0, 386943.0, 389532.0, 392427.0, 55579.166312505346, 73567.63216183885, 73678.2632173682, 76039.23960760322, 76952.23047769451, 463.99072018560116, 477.88769639134773, 1096.572336788653, 1131.4851742457163, 1134.65393055119, 8042.638081286474, 9279.304052195977, 9654.420734755937, 9813.803723925625, 9911.306208565331, 29173.85413073006, 31987.680123198472, 33508.49737253894, 33824.66175338215, 33901.0, 37732.43401348927, 38750.61249387583, 40175.0, 40493.59506404898, 41586.792066039474, 6799.660016999229, 7024.578525288499, 7028.9297107030325, 7112.0, 7121.9643901780155, 11148.43585975214, 11264.774704506028, 11305.943470282597, 11324.207305488866, 11693.239939403911, 9445.197158241352, 9593.520323983634, 9915.65295214664, 10035.799284014425, 10117.392956422638, 9838.852417213604, 10244.590216391261, 10253.282270241012, 10667.786644267226, 10711.464426778473, 9934.254930880357, 9969.551370188214, 10078.445685487368, 10261.640842570474, 10300.536475858755, 6688.632125233159, 6898.448124150156, 7034.788956331318, 7153.6423178839805, 7195.208527062124, 8550.187732165434, 9154.359194856563, 9346.626134954526, 9515.286353523376, 9630.229581633592], "unit": "score", "name": "jquery.html", "value": 7687.278734819144}, {"lowerIsBetter": false, "replicates": [1315.7960516120004, 1469.478335191007, 1477.2466042318415, 1668.591195157186, 1845.6677797996356, 7022.508424410287, 7574.09110906692, 7601.961990190048, 7604.923950760491, 7605.125410577785, 7253.564786112837, 7451.552906825595, 7458.4033277337685, 7464.066991626047, 7473.588952607604, 1977.3870100268891, 2253.459169799253, 2260.3445000949705, 2278.908843646252, 2286.3598192506042, 2245.955080898381, 2249.347689170139, 2250.516139030108, 2251.763564825694, 2253.7408198057187, 2189.244710574857, 2238.597052530544, 2239.6192647249927, 2243.540074284776, 2245.786650268222, 2239.1603148819195, 2247.4606094537357, 2248.4378905273684, 2305.1586171047616, 2311.641695537194, 2273.454370950976, 2312.4450131968374, 2316.6872472216205, 2318.362450326157, 2331.813454923602, 7892.210778922119, 7968.163342848975, 7972.3622110231045, 7974.082980457206, 7981.640826162837, 4653.395058642389, 4778.665493415462, 4810.7113573185725, 4817.253325734517, 4820.276958456225, 2901.10065879578, 2927.838968856712, 2959.7040295970446, 2972.1529364131334, 3035.544668299751, 837.5309826497181, 860.1914200651368, 875.369733791669, 889.1983290232795, 893.597880953567, 11151.107911367071, 11191.328520288727, 11193.10455163585, 11206.831897521544, 11241.381724005176, 4243.8090285937205, 4253.787310634518, 4320.308750599952, 4327.156204540084, 4331.242032644274, 9493.572789224501, 9507.524623768784, 9514.143727064597, 9514.714558563253, 9525.904740952641, 4878.487758785347, 4880.438749543777, 4882.658213924991, 4885.926711099336, 4894.045661096124, 4365.2797288447055, 4413.051193993243, 4416.492103408085, 4421.38100665907, 4422.624076953431, 3377.966220337765, 3569.464580312922, 3627.673509384168, 3651.032476393758, 3666.908327291839, 1104.6465131158113, 1109.6892869996414, 1113.3653817324048, 1138.9373584452935, 1146.2549342927164, 1068.5191663751343, 1086.9728256793644, 1249.188027781949, 1277.1889849945167, 1280.8462984441926, 7424.554526728413, 7467.7386291480625, 7482.775516734507, 7506.474546781673, 7516.586587737727, 1128.249713940237, 1133.0270475664138, 1133.1388145009853, 1170.0697945133638, 1175.5826681528106, 5707.172459993278, 5751.913721294184, 5758.3090029196765, 5758.827235182951, 5758.856028599319, 9468.289878259158, 9615.51922403877, 9730.902690973, 9874.851877221847, 9889.406635601887, 9721.0, 9735.610575576897, 9735.853962190573, 9742.46416447088, 9752.707418777307, 7419.258074192646, 7476.439267054992, 7486.288802563748, 7590.848183036308, 7635.770926872203, 7085.468589855678, 7111.53775004623, 7122.465815063994, 7129.25142860013, 7133.85732285341, 8370.414071015213, 8400.579971001547, 8744.300455963636, 8804.383693141419, 8827.07315731839, 8858.557072146496, 8858.955705221433, 8865.955670221607, 8951.507667078373, 8953.776155596162, 6592.736290548324, 6708.429783468265, 6711.697973591103, 6728.899066514105, 6730.293319201413, 6692.866142677217, 7375.520591161558, 7581.734639287599, 7582.090149182133, 7610.124835643972, 6996.755113571001, 7187.712491500491, 7204.0, 7227.891581626174, 7279.526830755984, 7068.71725130989, 7080.822979425556, 7103.467239956921, 7194.100737407824, 7210.639468026473, 7027.22700502934, 7121.8575628486105, 7143.464240182111, 7165.3551180394015, 7165.426765858614, 6485.0, 6519.119918810899, 6529.542931994714, 6531.183602049744, 6531.706073226811, 6403.743850246125, 6453.225612926291, 6454.967725161344, 6457.3865482779065, 6457.418832305115], "unit": "score", "name": "mootools.html", "value": 4503.896834267336}, {"lowerIsBetter": false, "replicates": [324.12809542331144, 324.7288514090734, 326.626013214869, 330.1416317574306, 330.8659992702956, 5741.397153298901, 5757.971210143949, 5783.334916484606, 5834.045594725772, 5883.0881213411885, 5749.798757043504, 5771.047777116782, 5774.364819869811, 5777.682227477487, 5800.245968024151, 4466.821327146927, 4472.955270447303, 4473.776311184444, 4481.215787237221, 4484.59638632523, 4265.957340426603, 4404.69167158299, 4410.4266445362055, 4475.753833539154, 4478.171538265431, 4335.046289816251, 4337.219300525904, 4339.761313127777, 4343.956560434387, 4347.347897815337, 4212.515560710527, 4357.172137293904, 4357.891052723691, 4365.628921541673, 4373.2565463871215, 3727.981360093182, 3730.123420996064, 3792.886213413602, 3796.3925771876366, 3805.2960202362374, 5470.699111548864, 5484.533814625722, 5494.395616482184, 5502.147167189092, 5508.338999320107, 4799.256115302133, 4958.404991401055, 5082.491750824925, 5084.059449001909, 5091.338126043591, 6063.757449702007, 6067.484263837579, 6091.908621370683, 6102.298235702907, 6124.418180272867, 4211.410402543646, 4223.155368926227, 4223.345381465878, 4228.577142285778, 4229.281022226198, 6299.338569450233, 6358.982562789977, 6393.136926514908, 6395.072714456378, 6406.67966601668, 4295.0, 4391.890202744893, 4396.318570621559, 4399.692021558524, 4414.558544145624, 4449.377087207794, 4468.463784345834, 4473.060657261946, 4494.505604383515, 4495.415595972503, 5166.560842328444, 5173.068847607392, 5173.896522069537, 5178.145605974972, 5181.119209734355, 6060.303065147565, 6204.13142160098, 6205.162303089025, 6206.937930620727, 6212.968935155386, 1585.69871724372, 1600.5118438876254, 1601.279424259088, 1601.871850251977, 1603.3426295218903, 1059.7562560611102, 1089.9400532970603, 1092.4814507834117, 1093.420487141816, 1102.5644870276196, 5862.70686465675, 5878.471597384625, 5878.559108066912, 5882.441168089024, 5883.852903677357, 6335.651539165298, 6337.112804207414, 6341.524385671093, 6343.111964324999, 6365.2998170201245, 5773.393793651606, 5784.074548072288, 5784.305883293948, 5788.479036886701, 5790.189373487715, 3313.1717070732316, 3419.7435192360176, 3420.521127042216, 3422.5208470814105, 3423.7432192585657, 6565.277819439858, 6616.139901812733, 6620.4041636252, 6627.469802415795, 6628.4697224221945, 6455.193100862392, 6468.256150542654, 6475.611463312216, 6479.870402591921, 6485.059666348353, 6312.968435157794, 6381.329960354189, 6512.34876512345, 6662.0340050692375, 6665.500087493458, 6331.638697680021, 6332.860085184711, 6335.239771227298, 6374.776882809079, 6376.298607153117, 6296.087067375113, 6303.6532990685955, 6306.747730090745, 6307.779227727007, 6320.1151838743535, 6481.740730370921, 6662.367075127855, 6664.50016248793, 6667.333266673294, 6680.63256520896, 4296.7851607420125, 4332.653387729038, 4333.674974376871, 4334.9783251083545, 4338.436003319548, 6381.521385896169, 6383.0, 6394.712237949397, 6398.520110991787, 6414.807555773335, 6029.60807547508, 6169.475594574332, 6182.1345011697495, 6183.783567575293, 6245.500359971101, 6190.7523699051535, 6201.224846894138, 6201.596896201732, 6205.100260462298, 6215.223097112861, 6120.265568131853, 6124.265088189446, 6124.38756124384, 6128.1726966858905, 6136.0, 6056.36408177135, 6190.102435146789, 6197.845053873689, 6205.317415084427, 6262.561620686508, 6047.123167140828, 6048.90926636092, 6058.303295121117, 6068.757249709962, 6116.0], "unit": "score", "name": "prototype.html", "value": 4640.894034641293}, {"lowerIsBetter": false, "replicates": [752.2928447259576, 811.4563242627443, 813.2802469814217, 823.8681810910248, 826.6894031182842, 13406.0, 13497.460101595936, 13749.518766843163, 13949.372278247478, 13980.650483737887, 13584.0, 13675.0, 13684.726305473885, 13689.65775855604, 13692.246926419042, 682.9760958366459, 698.1691786773748, 827.1191181391798, 827.8220182660742, 844.2275318083946, 840.5209030852417, 841.154639587214, 845.7547311279721, 845.8519759042174, 846.5301757524571, 885.3802338363139, 888.0187392930816, 888.0409158109259, 888.942218755782, 889.1419779912384, 705.8306006558415, 862.4782006885838, 874.2001069021837, 874.4141425245101, 875.5359659380539, 637.0730586995957, 642.5951650460227, 643.0322364840931, 643.1478291264094, 644.5552568727563, 13591.524296649668, 13617.319134043259, 13670.17978921258, 13678.863211367858, 13701.45194192231, 12316.0, 12475.251484910843, 12493.500259989589, 12629.101191396372, 12677.492900283978, 10361.274710770249, 10386.948065259701, 10399.79200415995, 11022.724431889266, 11159.330440173615, 3562.661547153042, 3621.27574485104, 3624.1664417184197, 3672.59601443841, 3675.5956844747056, 48580.271295930586, 49145.0, 49161.50838491605, 49375.0, 49379.0, 9596.136347728738, 9778.119969202806, 9903.851442228372, 10047.59809607622, 10163.085322321027, 17811.376601818873, 17848.91075544614, 17907.73138402925, 17914.641707165785, 17925.282988680567, 7512.737054203186, 7595.240475952361, 7754.457187996786, 7814.53112813233, 7835.5690437026515, 4234.1108367242605, 4259.041715614024, 4295.205387003414, 4307.461567304087, 4320.675949303752, 3059.464593696094, 3075.4156710224984, 3102.751779857606, 3105.767067469949, 3118.8128712277335, 556.0880156543273, 562.2016736234557, 576.19620629222, 576.4178180038108, 583.2679986616854, 606.8391876152823, 678.9355011273921, 686.306830101601, 698.0319651181704, 727.0548287226584, 8276.627551760184, 8288.21261980111, 8584.74245772628, 8601.182887625666, 8652.437591556529, 582.4932308891292, 671.6071098407486, 698.2493819144339, 710.1123595505618, 718.396546900606, 3868.3810590305416, 4100.6719462443525, 4152.854650087233, 4206.348016057516, 4321.10783300635, 54187.18719219215, 54251.0, 54335.72832135814, 55115.44884551103, 55443.72278138583, 46305.536944630796, 46571.30143047857, 46748.7662561685, 46954.0, 47646.52353476421, 41778.0, 42030.789846050575, 42057.57942420598, 42159.0, 42314.57685423168, 7370.48406611532, 7613.961930190314, 7725.072991240862, 7817.140114587504, 7864.921350786419, 32795.180120496225, 33272.33455330831, 33903.0, 33911.491327629614, 34001.0, 42343.0, 42384.576154239294, 42440.36339454973, 42756.5724342765, 42960.57039429565, 11505.137114716597, 11610.12924030718, 11630.592929247436, 11633.53465861356, 11661.6501504955, 11508.712282192677, 11563.785802490618, 11590.594329198437, 12490.125691201529, 12505.624831254712, 10507.789844203226, 10571.62999295021, 10728.51721672511, 11331.433428328715, 11333.489992950503, 10905.563777448813, 10988.725281868017, 11037.944810275898, 11500.654980350602, 11818.468168932246, 7813.157178554595, 10024.298299118991, 10428.426436546062, 10905.291156074829, 11086.334819910831, 8705.8694119587, 8733.868991964999, 9540.427574345562, 9570.569324380558, 9799.363041402286, 8700.738977830675, 8756.474611523328, 8917.063708310794, 9020.774480638036, 9068.455892646462], "unit": "score", "name": "yui.html", "value": 6241.9488532379255}], "name": "dromaeo_css", "value": 6736.401484533725}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 111.0, 108.0, 113.0, 112.0, 111.0, 101.0, 109.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 153.0, 166.0, 129.0, 160.0, 156.0, 130.0, 160.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [164.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 164.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 93.0, 92.0, 73.0, 76.0, 74.0, 124.0, 93.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 144.0, 96.0, 96.0, 97.0, 149.0, 96.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 111.2}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 114.0, 116.0, 115.0, 115.0, 115.0, 114.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 66.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 83.0, 83.0, 84.0, 83.0, 82.0, 82.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [117.0, 123.0, 118.0, 119.0, 118.0, 118.0, 116.0, 116.0, 128.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [150.0, 139.0, 162.0, 153.0, 155.0, 145.0, 150.0, 152.0, 147.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 71.0, 69.0, 69.0, 72.0, 70.0, 70.0, 69.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.2}], "name": "kraken", "value": 1518.8}]} 10:39:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,35]]", "result": "1518.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,35]]", "result": "6736.40"}}} 10:39:20 INFO - Return code: 0 10:39:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 10:39:20 INFO - # TBPL SUCCESS # 10:39:20 INFO - Running post-action listener: _resource_record_post_action 10:39:20 INFO - Running post-run listener: _resource_record_post_run 10:39:21 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 549011456; Read time: 0; Write time: 527444 10:39:21 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 250396672; Read time: 0; Write time: 300676 10:39:21 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 298553344; Read time: 0; Write time: 226768 10:39:21 INFO - Running post-run listener: _upload_blobber_files 10:39:21 INFO - Blob upload gear active. 10:39:21 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 10:39:21 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 10:39:21 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'] 10:39:21 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 10:39:22 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 10:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:23 INFO - (blobuploader) - INFO - Done attempting. 10:39:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:39:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:23 INFO - (blobuploader) - INFO - Done attempting. 10:39:23 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:23 INFO - Return code: 0 10:39:23 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 10:39:23 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79d0da0a9fbc495ae0306c72c53455f095865debef7e93d9a368e92ef376539c7a2ae148e50fc6c0e31d62c58683db456181922ae6a0f206abb77eae9f09c256", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e60323c2fbccff4192030438722a66956a4734a7379dc52c5c0b7385415384c30869f13ef26f0bdad49909f9cb85114fbbff965bbdb87a97d39a21553da9"} 10:39:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 10:39:23 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 10:39:23 INFO - Contents: 10:39:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79d0da0a9fbc495ae0306c72c53455f095865debef7e93d9a368e92ef376539c7a2ae148e50fc6c0e31d62c58683db456181922ae6a0f206abb77eae9f09c256", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e60323c2fbccff4192030438722a66956a4734a7379dc52c5c0b7385415384c30869f13ef26f0bdad49909f9cb85114fbbff965bbdb87a97d39a21553da9"} 10:39:23 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:23 INFO - Copying logs to upload dir... 10:39:23 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 10:39:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1227.833103 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 27 secs) (at 2016-02-12 10:39:23.566172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.569232) ========= 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79d0da0a9fbc495ae0306c72c53455f095865debef7e93d9a368e92ef376539c7a2ae148e50fc6c0e31d62c58683db456181922ae6a0f206abb77eae9f09c256", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e60323c2fbccff4192030438722a66956a4734a7379dc52c5c0b7385415384c30869f13ef26f0bdad49909f9cb85114fbbff965bbdb87a97d39a21553da9"} build_url:https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011576 build_url: 'https://queue.taskcluster.net/v1/task/c00jjlo2QVStfOMkVwPbxw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/79d0da0a9fbc495ae0306c72c53455f095865debef7e93d9a368e92ef376539c7a2ae148e50fc6c0e31d62c58683db456181922ae6a0f206abb77eae9f09c256", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd03e60323c2fbccff4192030438722a66956a4734a7379dc52c5c0b7385415384c30869f13ef26f0bdad49909f9cb85114fbbff965bbdb87a97d39a21553da9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.596746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.597347) ========= 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=00204705a9daa57ed339a427000001b9-1455295782.602179-980805405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 10:39:23.679678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 10:39:23.680005) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 10:39:23.680357) ========= ========= Total master_lag: 0.28 =========