builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-001 starttime: 1456297222.11 results: success (0) buildid: 20160223203453 builduid: 3f0893d204ea4befa64bd4c474701e69 revision: 9cf43731a81106da80a5ca3e3bd066d551666a9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.111000) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.111363) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.111646) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003016 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.149877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.150144) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.199460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.199749) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035407 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.246744) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.247067) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.247416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.247942) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-23 23:00:22-- 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% 85.5M=0s 2016-02-23 23:00:22 (85.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203677 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.464295) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.464585) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.159596 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.635003) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:22.635363) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9cf43731a81106da80a5ca3e3bd066d551666a9b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9cf43731a81106da80a5ca3e3bd066d551666a9b --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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-23 23:00:22,697 truncating revision to first 12 chars 2016-02-23 23:00:22,697 Setting DEBUG logging. 2016-02-23 23:00:22,697 attempt 1/10 2016-02-23 23:00:22,697 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9cf43731a811?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 23:00:23,133 unpacking tar archive at: fx-team-9cf43731a811/testing/mozharness/ program finished with exit code 0 elapsedTime=0.795400 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:23.442790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:23.443116) ========= echo 9cf43731a81106da80a5ca3e3bd066d551666a9b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9cf43731a81106da80a5ca3e3bd066d551666a9b'] 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9cf43731a81106da80a5ca3e3bd066d551666a9b program finished with exit code 0 elapsedTime=0.004588 script_repo_revision: '9cf43731a81106da80a5ca3e3bd066d551666a9b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:23.494102) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:23.494415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 23:00:23.506181) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-23 23:00:23.506457) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:00:23 INFO - MultiFileLogger online at 20160223 23:00:23 in /builds/slave/test-pgo 23:00:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:00:23 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:00:23 INFO - {'append_to_log': False, 23:00:23 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:00:23 INFO - 'blob_upload_branch': 'Fx-Team', 23:00:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:00:23 INFO - 'branch': 'Fx-Team', 23:00:23 INFO - 'buildbot_json_path': 'buildprops.json', 23:00:23 INFO - 'config_files': ('talos/linux_config.py',), 23:00:23 INFO - 'default_actions': ('clobber', 23:00:23 INFO - 'read-buildbot-config', 23:00:23 INFO - 'download-and-extract', 23:00:23 INFO - 'populate-webroot', 23:00:23 INFO - 'create-virtualenv', 23:00:23 INFO - 'install', 23:00:23 INFO - 'run-tests'), 23:00:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:00:23 INFO - 'download_minidump_stackwalk': True, 23:00:23 INFO - 'download_symbols': 'ondemand', 23:00:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:00:23 INFO - 'tooltool.py': '/tools/tooltool.py', 23:00:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:00:23 INFO - '/tools/misc-python/virtualenv.py')}, 23:00:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:00:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:00:23 INFO - 'installer_path': 'installer.exe', 23:00:23 INFO - 'log_level': 'info', 23:00:23 INFO - 'log_name': 'talos', 23:00:23 INFO - 'log_to_console': True, 23:00:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:00:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:00:23 INFO - 'opt_config_files': (), 23:00:23 INFO - 'pip_index': False, 23:00:23 INFO - 'sps_profile': False, 23:00:23 INFO - 'sps_profile_interval': 0, 23:00:23 INFO - 'suite': 'dromaeojs-e10s', 23:00:23 INFO - 'system_bits': '32', 23:00:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:00:23 INFO - 'title': 'talos-linux64-ix-001', 23:00:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:00:23 INFO - 'use_talos_json': True, 23:00:23 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:00:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:00:23 INFO - 'work_dir': 'build'} 23:00:23 INFO - ##### 23:00:23 INFO - ##### Running clobber step. 23:00:23 INFO - ##### 23:00:23 INFO - Running pre-action listener: _resource_record_pre_action 23:00:23 INFO - Running main action method: clobber 23:00:23 INFO - rmtree: /builds/slave/test-pgo/build 23:00:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:00:24 INFO - Running post-action listener: _resource_record_post_action 23:00:24 INFO - ##### 23:00:24 INFO - ##### Running read-buildbot-config step. 23:00:24 INFO - ##### 23:00:24 INFO - Running pre-action listener: _resource_record_pre_action 23:00:24 INFO - Running main action method: read_buildbot_config 23:00:24 INFO - Using buildbot properties: 23:00:24 INFO - { 23:00:24 INFO - "project": "", 23:00:24 INFO - "product": "firefox", 23:00:24 INFO - "script_repo_revision": "production", 23:00:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:00:24 INFO - "repository": "", 23:00:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:00:24 INFO - "buildid": "20160223203453", 23:00:24 INFO - "pgo_build": "True", 23:00:24 INFO - "basedir": "/builds/slave/test-pgo", 23:00:24 INFO - "buildnumber": 196, 23:00:24 INFO - "slavename": "talos-linux64-ix-001", 23:00:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:00:24 INFO - "platform": "ubuntu64_hw", 23:00:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:00:24 INFO - "branch": "fx-team", 23:00:24 INFO - "repo_path": "integration/fx-team", 23:00:24 INFO - "revision": "9cf43731a81106da80a5ca3e3bd066d551666a9b", 23:00:24 INFO - "stage_platform": "linux64-pgo", 23:00:24 INFO - "builduid": "3f0893d204ea4befa64bd4c474701e69", 23:00:24 INFO - "slavebuilddir": "test" 23:00:24 INFO - } 23:00:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 23:00:24 INFO - Running post-action listener: _resource_record_post_action 23:00:24 INFO - ##### 23:00:24 INFO - ##### Running download-and-extract step. 23:00:24 INFO - ##### 23:00:24 INFO - Running pre-action listener: _resource_record_pre_action 23:00:24 INFO - Running main action method: download_and_extract 23:00:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:00: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')]} 23:00:24 INFO - https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/test_packages.json 23:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/test_packages.json 23:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:00:26 INFO - Downloaded 1448 bytes. 23:00:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:00:26 INFO - Using the following test package requirements: 23:00:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:00:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:00:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'jsshell-linux-x86_64.zip'], 23:00:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:00:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:00:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:00:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:00:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:00:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:00:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:26 INFO - https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:28 INFO - Downloaded 23367308 bytes. 23:00:28 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'] 23:00:28 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 23:00:30 INFO - Return code: 0 23:00:30 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:00:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:30 INFO - https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 23:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:31 INFO - Downloaded 23367308 bytes. 23:00:31 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'] 23:00:31 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 23:00:33 INFO - Return code: 0 23:00:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:33 INFO - https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:35 INFO - Downloaded 10707015 bytes. 23:00:35 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'] 23:00:35 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 23:00:35 INFO - Return code: 0 23:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:35 INFO - https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:00:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:00:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:00:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DbDfDKLDR9-xWsISOcp-Kw/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 23:00:36 INFO - Downloaded 56655258 bytes. 23:00:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:00:36 INFO - mkdir: /builds/slave/test-pgo/properties 23:00:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:00:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:00:36 INFO - Contents: 23:00:36 INFO - build_url:https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 23:00:37 INFO - Running post-action listener: _resource_record_post_action 23:00:37 INFO - Running post-action listener: set_extra_try_arguments 23:00:37 INFO - ##### 23:00:37 INFO - ##### Running populate-webroot step. 23:00:37 INFO - ##### 23:00:37 INFO - Running pre-action listener: _resource_record_pre_action 23:00:37 INFO - Running main action method: populate_webroot 23:00:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:00:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:00:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:00:37 INFO - '--tppagecycles', 23:00:37 INFO - '7'], 23:00:37 INFO - 'tests': ['tsvgm']}}, 23:00:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:00:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:00:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 23:00:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:00:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'tests': ['damp', 'tps']}, 23:00:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['damp', 'tps']}, 23:00:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:00:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:00:37 INFO - 'other': {'tests': ['a11yr', 23:00:37 INFO - 'ts_paint', 23:00:37 INFO - 'tpaint', 23:00:37 INFO - 'sessionrestore', 23:00:37 INFO - 'sessionrestore_no_auto_restore']}, 23:00:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['a11yr', 23:00:37 INFO - 'ts_paint', 23:00:37 INFO - 'tpaint', 23:00:37 INFO - 'sessionrestore', 23:00:37 INFO - 'sessionrestore_no_auto_restore']}, 23:00:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['a11yr', 23:00:37 INFO - 'ts_paint', 23:00:37 INFO - 'tpaint', 23:00:37 INFO - 'sessionrestore', 23:00:37 INFO - 'sessionrestore_no_auto_restore']}, 23:00:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['a11yr', 23:00:37 INFO - 'ts_paint', 23:00:37 INFO - 'tpaint', 23:00:37 INFO - 'sessionrestore', 23:00:37 INFO - 'sessionrestore_no_auto_restore']}, 23:00:37 INFO - 'other_l64': {'tests': ['a11yr', 23:00:37 INFO - 'ts_paint', 23:00:37 INFO - 'tpaint', 23:00:37 INFO - 'sessionrestore', 23:00:37 INFO - 'sessionrestore_no_auto_restore']}, 23:00:37 INFO - 'other_nol64': {'tests': ['a11yr', 23:00:37 INFO - 'ts_paint', 23:00:37 INFO - 'tpaint', 23:00:37 INFO - 'sessionrestore', 23:00:37 INFO - 'sessionrestore_no_auto_restore']}, 23:00:37 INFO - 'svgr': {'tests': ['tsvgx', 23:00:37 INFO - 'tsvgr_opacity', 23:00:37 INFO - 'tart', 23:00:37 INFO - 'tscrollx', 23:00:37 INFO - 'cart']}, 23:00:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['tsvgx', 23:00:37 INFO - 'tsvgr_opacity', 23:00:37 INFO - 'tart', 23:00:37 INFO - 'tscrollx', 23:00:37 INFO - 'cart']}, 23:00:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'tests': ['tp5o']}, 23:00:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'talos_options': ['--e10s'], 23:00:37 INFO - 'tests': ['tp5o']}, 23:00:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'talos_options': ['--xperf_path', 23:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:37 INFO - 'tests': ['tp5n']}, 23:00:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:37 INFO - 'talos_options': ['--e10s', 23:00:37 INFO - '--xperf_path', 23:00:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:37 INFO - 'tests': ['tp5n']}}, 23:00:37 INFO - 'talos.zip': {'path': '', 23:00:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:00:37 INFO - Running post-action listener: _resource_record_post_action 23:00:37 INFO - ##### 23:00:37 INFO - ##### Running create-virtualenv step. 23:00:37 INFO - ##### 23:00:37 INFO - Running pre-action listener: _resource_record_pre_action 23:00:37 INFO - Running main action method: create_virtualenv 23:00:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:00:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 23:00:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:00:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:00:37 INFO - Using real prefix '/usr' 23:00:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:00:38 INFO - Installing distribute.............................................................................................................................................................................................done. 23:00:40 INFO - Installing pip.................done. 23:00:40 INFO - Return code: 0 23:00:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:40 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:40 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 23:00:40 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 23:00:40 INFO - Using env: {'DISPLAY': ':0', 23:00:40 INFO - 'HOME': '/home/cltbld', 23:00:40 INFO - 'LANG': 'en_US.UTF-8', 23:00:40 INFO - 'LANGUAGE': 'en_US:en', 23:00:40 INFO - 'LOGNAME': 'cltbld', 23:00:40 INFO - 'MAIL': '/var/mail/cltbld', 23:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:40 INFO - 'MOZ_NO_REMOTE': '1', 23:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:40 INFO - 'NO_EM_RESTART': '1', 23:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:40 INFO - 'SHELL': '/bin/bash', 23:00:40 INFO - 'SHLVL': '1', 23:00:40 INFO - 'TERM': 'linux', 23:00:40 INFO - 'TMOUT': '86400', 23:00:40 INFO - 'USER': 'cltbld', 23:00:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:40 INFO - '_': '/tools/buildbot/bin/python'} 23:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:41 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 23:00:41 INFO - Cleaning up... 23:00:41 INFO - Return code: 0 23:00:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:00:41 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')]} 23:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:41 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')]} 23:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:41 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:41 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 23:00:41 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 23:00:41 INFO - Using env: {'DISPLAY': ':0', 23:00:41 INFO - 'HOME': '/home/cltbld', 23:00:41 INFO - 'LANG': 'en_US.UTF-8', 23:00:41 INFO - 'LANGUAGE': 'en_US:en', 23:00:41 INFO - 'LOGNAME': 'cltbld', 23:00:41 INFO - 'MAIL': '/var/mail/cltbld', 23:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:41 INFO - 'MOZ_NO_REMOTE': '1', 23:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:41 INFO - 'NO_EM_RESTART': '1', 23:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:41 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:41 INFO - 'SHELL': '/bin/bash', 23:00:41 INFO - 'SHLVL': '1', 23:00:41 INFO - 'TERM': 'linux', 23:00:41 INFO - 'TMOUT': '86400', 23:00:41 INFO - 'USER': 'cltbld', 23:00:41 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:41 INFO - '_': '/tools/buildbot/bin/python'} 23:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:41 INFO - Downloading/unpacking psutil>=0.7.1 23:00:41 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 23:00:41 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 23:00:41 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 23:00:41 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 23:00:41 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 23:00:41 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 23:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:43 INFO - Installing collected packages: psutil 23:00:43 INFO - Running setup.py install for psutil 23:00:43 INFO - building 'psutil._psutil_linux' extension 23:00:43 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 23:00:44 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 23:00:44 INFO - building 'psutil._psutil_posix' extension 23:00:44 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 23:00:44 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 23:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:44 INFO - Successfully installed psutil 23:00:44 INFO - Cleaning up... 23:00:44 INFO - Return code: 0 23:00:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 23:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:00:44 INFO - Using env: {'DISPLAY': ':0', 23:00:44 INFO - 'HOME': '/home/cltbld', 23:00:44 INFO - 'LANG': 'en_US.UTF-8', 23:00:44 INFO - 'LANGUAGE': 'en_US:en', 23:00:44 INFO - 'LOGNAME': 'cltbld', 23:00:44 INFO - 'MAIL': '/var/mail/cltbld', 23:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:44 INFO - 'MOZ_NO_REMOTE': '1', 23:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:44 INFO - 'NO_EM_RESTART': '1', 23:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:44 INFO - 'SHELL': '/bin/bash', 23:00:44 INFO - 'SHLVL': '1', 23:00:44 INFO - 'TERM': 'linux', 23:00:44 INFO - 'TMOUT': '86400', 23:00:44 INFO - 'USER': 'cltbld', 23:00:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:44 INFO - '_': '/tools/buildbot/bin/python'} 23:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:00:44 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 23:00:44 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 23:00:44 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 23:00:44 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 23:00:44 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 23:00:44 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 23:00:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:00:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:00:46 INFO - Installing collected packages: mozsystemmonitor 23:00:46 INFO - Running setup.py install for mozsystemmonitor 23:00:46 INFO - Successfully installed mozsystemmonitor 23:00:46 INFO - Cleaning up... 23:00:46 INFO - Return code: 0 23:00:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:00: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')]} 23:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:46 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:46 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 23:00:46 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 23:00:46 INFO - Using env: {'DISPLAY': ':0', 23:00:46 INFO - 'HOME': '/home/cltbld', 23:00:46 INFO - 'LANG': 'en_US.UTF-8', 23:00:46 INFO - 'LANGUAGE': 'en_US:en', 23:00:46 INFO - 'LOGNAME': 'cltbld', 23:00:46 INFO - 'MAIL': '/var/mail/cltbld', 23:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:46 INFO - 'MOZ_NO_REMOTE': '1', 23:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:46 INFO - 'NO_EM_RESTART': '1', 23:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:46 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:46 INFO - 'SHELL': '/bin/bash', 23:00:46 INFO - 'SHLVL': '1', 23:00:46 INFO - 'TERM': 'linux', 23:00:46 INFO - 'TMOUT': '86400', 23:00:46 INFO - 'USER': 'cltbld', 23:00:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:46 INFO - '_': '/tools/buildbot/bin/python'} 23:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:47 INFO - Downloading/unpacking blobuploader==1.2.4 23:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:00:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:00:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:00:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 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 23:00:49 INFO - Downloading docopt-0.6.1.tar.gz 23:00:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:00:49 INFO - Installing collected packages: blobuploader, requests, docopt 23:00:49 INFO - Running setup.py install for blobuploader 23:00:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:00:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:00:49 INFO - Running setup.py install for requests 23:00:50 INFO - Running setup.py install for docopt 23:00:50 INFO - Successfully installed blobuploader requests docopt 23:00:50 INFO - Cleaning up... 23:00:50 INFO - Return code: 0 23:00:50 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:50 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:50 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 23:00:50 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 23:00:50 INFO - Using env: {'DISPLAY': ':0', 23:00:50 INFO - 'HOME': '/home/cltbld', 23:00:50 INFO - 'LANG': 'en_US.UTF-8', 23:00:50 INFO - 'LANGUAGE': 'en_US:en', 23:00:50 INFO - 'LOGNAME': 'cltbld', 23:00:50 INFO - 'MAIL': '/var/mail/cltbld', 23:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:50 INFO - 'MOZ_NO_REMOTE': '1', 23:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:50 INFO - 'NO_EM_RESTART': '1', 23:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:50 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:50 INFO - 'SHELL': '/bin/bash', 23:00:50 INFO - 'SHLVL': '1', 23:00:50 INFO - 'TERM': 'linux', 23:00:50 INFO - 'TMOUT': '86400', 23:00:50 INFO - 'USER': 'cltbld', 23:00:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:50 INFO - '_': '/tools/buildbot/bin/python'} 23:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:50 INFO - Running setup.py (path:/tmp/pip-Nh_k93-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:50 INFO - Running setup.py (path:/tmp/pip-k1TUhf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:50 INFO - Running setup.py (path:/tmp/pip-LPr9z5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:50 INFO - Running setup.py (path:/tmp/pip-T_iArS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:50 INFO - Running setup.py (path:/tmp/pip-O840JT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:50 INFO - Running setup.py (path:/tmp/pip-F3a_kQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:50 INFO - Running setup.py (path:/tmp/pip-rRvf4b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:50 INFO - Running setup.py (path:/tmp/pip-EldwNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:51 INFO - Running setup.py (path:/tmp/pip-_sK2U9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:51 INFO - Running setup.py (path:/tmp/pip-cazD2w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:51 INFO - Running setup.py (path:/tmp/pip-PzYnz8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:51 INFO - Running setup.py (path:/tmp/pip-rdKBay-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:51 INFO - Running setup.py (path:/tmp/pip-aCdSJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:51 INFO - Running setup.py (path:/tmp/pip-WknhzL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:51 INFO - Running setup.py (path:/tmp/pip-5tgYIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:51 INFO - Running setup.py (path:/tmp/pip-O_Kmj3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:51 INFO - Running setup.py (path:/tmp/pip-Lsjo8g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:00:51 INFO - Running setup.py install for manifestparser 23:00:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:00:51 INFO - Running setup.py install for mozcrash 23:00:51 INFO - Running setup.py install for mozdebug 23:00:51 INFO - Running setup.py install for mozdevice 23:00:52 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Running setup.py install for mozfile 23:00:52 INFO - Running setup.py install for mozhttpd 23:00:52 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Running setup.py install for mozinfo 23:00:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Running setup.py install for mozInstall 23:00:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Running setup.py install for mozleak 23:00:52 INFO - Running setup.py install for mozlog 23:00:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Running setup.py install for moznetwork 23:00:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:00:52 INFO - Running setup.py install for mozprocess 23:00:52 INFO - Running setup.py install for mozprofile 23:00:53 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:00:53 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:00:53 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:00:53 INFO - Running setup.py install for mozrunner 23:00:53 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:00:53 INFO - Running setup.py install for mozscreenshot 23:00:53 INFO - Running setup.py install for moztest 23:00:53 INFO - Running setup.py install for mozversion 23:00:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:00:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:00:53 INFO - Cleaning up... 23:00:53 INFO - Return code: 0 23:00:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:00:53 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')]} 23:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:53 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')]} 23:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:53 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:53 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 23:00:53 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 23:00:53 INFO - Using env: {'DISPLAY': ':0', 23:00:53 INFO - 'HOME': '/home/cltbld', 23:00:53 INFO - 'LANG': 'en_US.UTF-8', 23:00:53 INFO - 'LANGUAGE': 'en_US:en', 23:00:53 INFO - 'LOGNAME': 'cltbld', 23:00:53 INFO - 'MAIL': '/var/mail/cltbld', 23:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:53 INFO - 'MOZ_NO_REMOTE': '1', 23:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:53 INFO - 'NO_EM_RESTART': '1', 23:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:53 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:53 INFO - 'SHELL': '/bin/bash', 23:00:53 INFO - 'SHLVL': '1', 23:00:53 INFO - 'TERM': 'linux', 23:00:53 INFO - 'TMOUT': '86400', 23:00:53 INFO - 'USER': 'cltbld', 23:00:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:53 INFO - '_': '/tools/buildbot/bin/python'} 23:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:53 INFO - Running setup.py (path:/tmp/pip-MnLgBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:00:53 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)) 23:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:53 INFO - Running setup.py (path:/tmp/pip-NlEpWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:00:53 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)) 23:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:53 INFO - Running setup.py (path:/tmp/pip-nWDwL0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:00:53 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)) 23:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:53 INFO - Running setup.py (path:/tmp/pip-wwksGF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:54 INFO - Running setup.py (path:/tmp/pip-jLIygX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:54 INFO - Running setup.py (path:/tmp/pip-58n1uN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:54 INFO - Running setup.py (path:/tmp/pip-tnOJGd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:54 INFO - Running setup.py (path:/tmp/pip-WuVCjr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:54 INFO - Running setup.py (path:/tmp/pip-ljTclt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:54 INFO - Running setup.py (path:/tmp/pip-0FRY6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:54 INFO - Running setup.py (path:/tmp/pip-M8ak2P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:54 INFO - Running setup.py (path:/tmp/pip-d9s2HB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:54 INFO - Running setup.py (path:/tmp/pip-XE3F5J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:54 INFO - Running setup.py (path:/tmp/pip-U5aXoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:54 INFO - Running setup.py (path:/tmp/pip-9u1b0a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:54 INFO - Running setup.py (path:/tmp/pip-Y2wjXu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:00:54 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)) 23:00:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:54 INFO - Running setup.py (path:/tmp/pip-Pwa4VC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:00:54 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)) 23:00:54 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)) 23:00:54 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)) 23:00:54 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)) 23:00:54 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)) 23:00:54 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)) 23:00:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:00:54 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 23:00:54 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 23:00:54 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 23:00:54 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 23:00:54 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 23:00:54 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 23:00:56 INFO - Downloading blessings-1.6.tar.gz 23:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:00:56 INFO - Installing collected packages: blessings 23:00:56 INFO - Running setup.py install for blessings 23:00:56 INFO - Successfully installed blessings 23:00:56 INFO - Cleaning up... 23:00:57 INFO - Return code: 0 23:00:57 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:00:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:00:57 INFO - Reading from file tmpfile_stdout 23:00:57 INFO - Current package versions: 23:00:57 INFO - argparse == 1.2.1 23:00:57 INFO - blessings == 1.6 23:00:57 INFO - blobuploader == 1.2.4 23:00:57 INFO - docopt == 0.6.1 23:00:57 INFO - manifestparser == 1.1 23:00:57 INFO - mozInstall == 1.12 23:00:57 INFO - mozcrash == 0.16 23:00:57 INFO - mozdebug == 0.1 23:00:57 INFO - mozdevice == 0.48 23:00:57 INFO - mozfile == 1.2 23:00:57 INFO - mozhttpd == 0.7 23:00:57 INFO - mozinfo == 0.9 23:00:57 INFO - mozleak == 0.1 23:00:57 INFO - mozlog == 3.1 23:00:57 INFO - moznetwork == 0.27 23:00:57 INFO - mozprocess == 0.22 23:00:57 INFO - mozprofile == 0.28 23:00:57 INFO - mozrunner == 6.11 23:00:57 INFO - mozscreenshot == 0.1 23:00:57 INFO - mozsystemmonitor == 0.0 23:00:57 INFO - moztest == 0.7 23:00:57 INFO - mozversion == 1.4 23:00:57 INFO - psutil == 3.1.1 23:00:57 INFO - requests == 1.2.3 23:00:57 INFO - wsgiref == 0.1.2 23:00:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:00: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')]} 23:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:57 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:57 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 23:00:57 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 23:00:57 INFO - Using env: {'DISPLAY': ':0', 23:00:57 INFO - 'HOME': '/home/cltbld', 23:00:57 INFO - 'LANG': 'en_US.UTF-8', 23:00:57 INFO - 'LANGUAGE': 'en_US:en', 23:00:57 INFO - 'LOGNAME': 'cltbld', 23:00:57 INFO - 'MAIL': '/var/mail/cltbld', 23:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:57 INFO - 'MOZ_NO_REMOTE': '1', 23:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:57 INFO - 'NO_EM_RESTART': '1', 23:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:57 INFO - 'SHELL': '/bin/bash', 23:00:57 INFO - 'SHLVL': '1', 23:00:57 INFO - 'TERM': 'linux', 23:00:57 INFO - 'TMOUT': '86400', 23:00:57 INFO - 'USER': 'cltbld', 23:00:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:57 INFO - '_': '/tools/buildbot/bin/python'} 23:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 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)) 23:00:57 INFO - Cleaning up... 23:00:57 INFO - Return code: 0 23:00:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:00: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')]} 23:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 23:00:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:00:57 INFO - Using env: {'DISPLAY': ':0', 23:00:57 INFO - 'HOME': '/home/cltbld', 23:00:57 INFO - 'LANG': 'en_US.UTF-8', 23:00:57 INFO - 'LANGUAGE': 'en_US:en', 23:00:57 INFO - 'LOGNAME': 'cltbld', 23:00:57 INFO - 'MAIL': '/var/mail/cltbld', 23:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:57 INFO - 'MOZ_NO_REMOTE': '1', 23:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:57 INFO - 'NO_EM_RESTART': '1', 23:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:57 INFO - 'SHELL': '/bin/bash', 23:00:57 INFO - 'SHLVL': '1', 23:00:57 INFO - 'TERM': 'linux', 23:00:57 INFO - 'TMOUT': '86400', 23:00:57 INFO - 'USER': 'cltbld', 23:00:57 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:57 INFO - '_': '/tools/buildbot/bin/python'} 23:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:57 INFO - Downloading/unpacking jsonschema 23:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:00:59 INFO - Downloading/unpacking functools32 (from jsonschema) 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:59 INFO - Downloading functools32-3.2.3-2.tar.gz 23:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:00:59 INFO - warning: no files found matching '*.txt' 23:00:59 INFO - no previously-included directories found matching 'build' 23:00:59 INFO - no previously-included directories found matching 'dist' 23:00:59 INFO - no previously-included directories found matching '.git*' 23:00:59 INFO - Installing collected packages: jsonschema, functools32 23:00:59 INFO - Running setup.py install for functools32 23:00:59 INFO - warning: no files found matching '*.txt' 23:00:59 INFO - no previously-included directories found matching 'build' 23:00:59 INFO - no previously-included directories found matching 'dist' 23:00:59 INFO - no previously-included directories found matching '.git*' 23:00:59 INFO - Successfully installed jsonschema functools32 23:00:59 INFO - Cleaning up... 23:00:59 INFO - Return code: 0 23:00:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:00: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')]} 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:59 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 0x7fdb8fc6df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2518670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, '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': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', '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 23:00:59 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 23:00:59 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 23:00:59 INFO - Using env: {'DISPLAY': ':0', 23:00:59 INFO - 'HOME': '/home/cltbld', 23:00:59 INFO - 'LANG': 'en_US.UTF-8', 23:00:59 INFO - 'LANGUAGE': 'en_US:en', 23:00:59 INFO - 'LOGNAME': 'cltbld', 23:00:59 INFO - 'MAIL': '/var/mail/cltbld', 23:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:59 INFO - 'MOZ_NO_REMOTE': '1', 23:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:59 INFO - 'NO_EM_RESTART': '1', 23:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:00:59 INFO - 'PWD': '/builds/slave/test-pgo', 23:00:59 INFO - 'SHELL': '/bin/bash', 23:00:59 INFO - 'SHLVL': '1', 23:00:59 INFO - 'TERM': 'linux', 23:00:59 INFO - 'TMOUT': '86400', 23:00:59 INFO - 'USER': 'cltbld', 23:00:59 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:59 INFO - '_': '/tools/buildbot/bin/python'} 23:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:00 INFO - Downloading/unpacking flake8 23:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:01:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:02 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:01:02 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 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 23:01:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:02 INFO - no previously-included directories found matching 'docs/_build' 23:01:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:01:02 INFO - Running setup.py install for pep8 23:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:01:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:01:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:01:02 INFO - no previously-included directories found matching 'docs/_build' 23:01:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:01:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:01:02 INFO - Cleaning up... 23:01:02 INFO - Return code: 0 23:01:02 INFO - Running post-action listener: _resource_record_post_action 23:01:02 INFO - Running post-action listener: _start_resource_monitoring 23:01:02 INFO - Starting resource monitoring. 23:01:02 INFO - ##### 23:01:02 INFO - ##### Running install step. 23:01:02 INFO - ##### 23:01:02 INFO - Running pre-action listener: _resource_record_pre_action 23:01:02 INFO - Running main action method: install 23:01:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:01:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:01:03 INFO - Reading from file tmpfile_stdout 23:01:03 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:01:03 INFO - Reading from file tmpfile_stdout 23:01:03 INFO - Output received: 23:01:03 INFO - Usage: mozinstall [options] installer 23:01:03 INFO - Options: 23:01:03 INFO - -h, --help show this help message and exit 23:01:03 INFO - -d DEST, --destination=DEST 23:01:03 INFO - Directory to install application into. [default: 23:01:03 INFO - "/builds/slave/test-pgo"] 23:01:03 INFO - --app=APP Application being installed. [default: firefox] 23:01:03 INFO - mkdir: /builds/slave/test-pgo/build/application 23:01:03 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'] 23:01:03 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 23:01:19 INFO - Reading from file tmpfile_stdout 23:01:19 INFO - Output received: 23:01:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:01:19 INFO - Running post-action listener: _resource_record_post_action 23:01:19 INFO - ##### 23:01:19 INFO - ##### Running run-tests step. 23:01:19 INFO - ##### 23:01:19 INFO - Running pre-action listener: _resource_record_pre_action 23:01:19 INFO - Running main action method: run_tests 23:01:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:01:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:01:19 INFO - Python 2.7.3 23:01:19 INFO - Return code: 0 23:01:19 INFO - grabbing minidump binary from tooltool 23:01:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:01:19 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 0x25a78c0>, '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 0x25a87c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a8c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:01:19 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 23:01:19 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 23:01:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:19 INFO - Return code: 0 23:01:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:01:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:01:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:01:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:01:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:01:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:01:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:01:20 INFO - Return code: 0 23:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 23:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:01:20 INFO - Using env: {'DISPLAY': ':0', 23:01:20 INFO - 'HOME': '/home/cltbld', 23:01:20 INFO - 'LANG': 'en_US.UTF-8', 23:01:20 INFO - 'LANGUAGE': 'en_US:en', 23:01:20 INFO - 'LOGNAME': 'cltbld', 23:01:20 INFO - 'MAIL': '/var/mail/cltbld', 23:01:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:01:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:20 INFO - 'MOZ_NO_REMOTE': '1', 23:01:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:20 INFO - 'NO_EM_RESTART': '1', 23:01:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:01:20 INFO - 'PWD': '/builds/slave/test-pgo', 23:01:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:01:20 INFO - 'SHELL': '/bin/bash', 23:01:20 INFO - 'SHLVL': '1', 23:01:20 INFO - 'TERM': 'linux', 23:01:20 INFO - 'TMOUT': '86400', 23:01:20 INFO - 'USER': 'cltbld', 23:01:20 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251', 23:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:20 INFO - '_': '/tools/buildbot/bin/python'} 23:01:20 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:01:21 INFO - mozversion application_buildid: 20160223203453 23:01:21 INFO - mozversion application_changeset: 9cf43731a81106da80a5ca3e3bd066d551666a9b 23:01:21 INFO - mozversion application_display_name: Nightly 23:01:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:21 INFO - mozversion application_name: Firefox 23:01:21 INFO - mozversion application_remotingname: firefox 23:01:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:01:21 INFO - mozversion application_vendor: Mozilla 23:01:21 INFO - mozversion application_version: 47.0a1 23:01:21 INFO - mozversion platform_buildid: 20160223203453 23:01:21 INFO - mozversion platform_changeset: 9cf43731a81106da80a5ca3e3bd066d551666a9b 23:01:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:01:21 INFO - mozversion platform_version: 47.0a1 23:01:21 INFO - using testdate: 1456297281 23:01:21 INFO - actual date: 1456297281 23:01:21 INFO - starting webserver on 'localhost:57414' 23:01:21 INFO - SUITE-START | Running 2 tests 23:01:21 INFO - TEST-START | dromaeo_css 23:01:21 INFO - operating with platform_type : linux_ 23:01:21 INFO - Initialising browser for dromaeo_css test... 23:01:21 INFO - TEST-INFO | started process 3290 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6Je73H/profile http://localhost:57414/getInfo.html) 23:01:25 INFO - PROCESS | 3290 | 23:01:25 INFO - PROCESS | 3290 | (process:3373): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:26 INFO - PROCESS | 3290 | __metrics Screen width/height:1600/1200 23:01:26 INFO - PROCESS | 3290 | colorDepth:24 23:01:26 INFO - PROCESS | 3290 | Browser inner width/height: 1024/697 23:01:26 INFO - PROCESS | 3290 | __metrics 23:01:27 ERROR - PROCESS | 3290 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:01:28 INFO - TEST-INFO | 3290: exit 0 23:01:28 INFO - Browser initialized. 23:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 23:01:28 INFO - TEST-INFO | started process 3424 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6Je73H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:29 INFO - PROCESS | 3424 | 23:01:29 INFO - PROCESS | 3424 | (process:3480): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:01:40 INFO - PROCESS | 3424 | RSS: Main: 155488256 23:01:40 INFO - PROCESS | 3424 | 23:02:29 INFO - PROCESS | 3424 | 1456297349761 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] 23:04:38 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:57414/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57414/tests/dromaeo/cssquery-ext.html) 23:04:39 INFO - PROCESS | 3424 | RSS: Main: 164466688 23:04:39 INFO - PROCESS | 3424 | 23:07:41 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:57414/tests/dromaeo/cssquery-ext.html (next: http://localhost:57414/tests/dromaeo/cssquery-jquery.html) 23:07:42 INFO - PROCESS | 3424 | RSS: Main: 160051200 23:07:42 INFO - PROCESS | 3424 | 23:10:44 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:57414/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57414/tests/dromaeo/cssquery-mootools.html) 23:10:44 INFO - PROCESS | 3424 | RSS: Main: 159973376 23:10:44 INFO - PROCESS | 3424 | 23:13:46 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:57414/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57414/tests/dromaeo/cssquery-prototype.html) 23:13:47 INFO - PROCESS | 3424 | RSS: Main: 159453184 23:13:47 INFO - PROCESS | 3424 | 23:16:49 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:57414/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57414/tests/dromaeo/cssquery-yui.html) 23:16:50 INFO - PROCESS | 3424 | RSS: Main: 160092160 23:16:50 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:57414/tests/dromaeo/cssquery-yui.html (next: http://localhost:57414/tests/dromaeo/cssquery-dojo.html) 23:19:52 INFO - PROCESS | 3424 | RSS: Main: 162463744 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | __start_tp_report 23:19:52 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 23:19:52 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 23:19:52 INFO - PROCESS | 3424 | |i|pagename|runs| 23:19:52 INFO - PROCESS | 3424 | |0;dojo.html;3205.8397080145996;3230.709236168744;3274.639789623141;3285.8028518288907;3291.243014106757;5240.056789777838;5266.973665131669;5362.249285100089;5382.757775900089;5403.189521571761;5297.152455607104;5361.222622719703;5371.919421208685;5381.48875856794;5434.972825135868;4869.196582563882;4877.634177436688;4905.068037072962;5052.9242061369105;5075.5178258065425;4797.376341075656;4920.8031678732805;4937.580305674022;4991.076650819592;5059.266406371074;4865.2945322928335;4866.829660961885;4905.656604037718;4916.3608730864935;4931.211006238985;4900.191468407708;4901.411830580353;4917.164082106051;4928.1129396708575;4950.3069570260195;4846.709197448165;4889.168841296988;4895.388076490439;4916.680415772999;4928.433230178503;5149.047426226122;5170.9741451292875;5181.663191892515;5184.9740751296;5213;5606.887862242732;5698.202251684767;5700.201971723962;5700.572457065737;5705.115707065412;5692.800751973702;5710.486056254916;5778.5377169826315;5796.1595568642315;5867.794627188028;5288.629795914288;5323.760430780624;5324.494173053554;5398.163284690879;5409.459054094598;5775.306963164448;5779.566532510079;5784.71076446176;5786.768529258867;5789.913151302734;5436.565074794007;5505.449455054462;5585.776568937278;5593.692346920877;5643.153526970905;5628.859278517988;5633.802816901471;5636.971815140898;5648;5655.971720141373;5538.113901775777;5583.720813959286;5692.686902220417;5715.5427565794635;5722.284714410699;5695.117256825199;5697.974364614326;5714.971425142848;5717.599768016199;5719.227904232958;4438.134563760036;4450.443694538183;4464.196444639996;4488.798004089824;4497.8425755098415;3952.7628342299554;3955.4660120883887;3959.5248570171766;3988.9202215956097;4023.3964905264443;5270.472952704776;5430.239766432703;5445.128779395278;5457.5633949283965;5530.557555395559;5779.219805326311;5779.248697669276;5782.537397008229;5784.65292082468;5785.103308987113;5359.973200133974;5378.327709036371;5390.946090539122;5394.433584473652;5430.185472179126;4795.520447955177;4830;4888.437829649564;4933.876653083702;5001.649884508122;5958.165856780054;6008.068749343859;6011.579189456696;6014.127951447103;6029.186059881948;5567.081431563909;5744.942550574441;5781.768729250783;5784.074548072288;5785.508231800344;5961.463468287875;6001.129836173643;6018.127371531016;6033.607815491979;6040.516758659209;5679.318481782213;5685.403032681509;5714.971425142848;5733.971330143323;5749.425057494217;5603.5797315202335;5700.287464066992;5746.885062298647;5786.710664466844;5807.361190268983;5519.751611177427;5549.334079910436;5549.944500554942;5560;5618.831435056954;5543.196236545759;5583.0787919992745;5597.384287728428;5602.2717046783655;5626.634268772516;5590.496855283044;5617;5644.379118297066;5648.039833228278;5696.401877802771;5634.830955071355;5656.23640808502;5748.827535173951;5762.337331206965;5765.625234359753;5369;5562.137868630369;5580.135079062752;5582.051051321367;5630.127330263816 23:19:52 INFO - PROCESS | 3424 | |1;ext.html;500.35204410288674;536.2144458368491;551.3383939272874;570.8116321613868;575.7380391921677;34174.145646358855;34709.47935780962;34719.82640086802;34741;34883.82558087206;35568.64431355692;35760.28479430416;35976.82011589945;35995;36027.639723602755;8195.549244791535;8340.749777506684;8375.078741338479;8376.58117094146;8402.285805706522;8350.540720260384;8391.076981532027;8438.240558349748;8463.703770368007;8518.063013068557;8461.703840365588;8467;8506;8508.829823403528;8523.872141917876;8373.49759014455;8398.160183981583;8401;8409.70566030189;8416;8414.873776893352;8609.741707748777;8615.353848461327;8654.78363040929;8667.089955554638;36006.45990310147;37081;37273.25453490942;37354.25291494155;37438;2695.2318589202177;3001.3997200559975;3120.672329405425;3125.6092988376454;3226.5805445291962;27539.86230068857;28611;28763.56854647182;28911.855440722873;29119.56320655192;3809.5999920008553;3999.4000899864964;3999.42008408782;4001.97999010006;4040.5151381834075;245458;251158;251576;253677.7316113426;255395;41825;41921.79039104785;42042;42307;60046.39953600495;42520.57479425228;43014.569854301684;43156.13687726228;43212;43247.13505729868;15081.54755357341;15200.695986080216;15267.465638702592;15311.15788631636;15337.233138343037;11964.162508624313;12114.0914431418;12121.727218642092;12136.211146275464;12192.756144877052;14134.85865141356;14143.151410915378;14216.644583885485;14254.216018118896;14304.499342522962;5689.317281926113;5772.105323674838;5813.273340832396;5873.647581145145;5892.469677729025;895.4358753985078;919.3197034194648;934.6588495199339;1067.9213993866251;1098.0776148035688;28282.43435131286;31315.84342078275;32669.346613068083;32723.50914736281;32975;917.6512925088424;965.2422848064236;988.6342053440129;1018.4958445569342;1137.9089672826153;13411.597652070453;13556;13831.446742130403;13869.930650346683;13939;364821;369668;370615;371016;371031;52201.21698174455;52665.7366713164;52773.472265277625;52829.2075618866;53639.172474476705;1314.493919840849;1336.7727486327349;1340.604521666111;1349.6490912362856;1354.4040622126035;25956.480870382107;26499;26845.731542684323;27193.456130876875;27314.86342568354;40097.59902400939;40667.1866562673;40693.593064068984;40926;41552.168956620095;286600;288847;289285;289457;290540;31441.8427907859;31519.36961260808;41778.37332439955;43654;43897.78051109724;39786.20427591374;40221.38007579332;40718.59281407148;40787.38818917778;41096;33205.83397082999;36126.277474450886;36371.81814091018;36673.63326366702;36975.63024369722;35686.464703028956;36526.634733652325;36729.44905826468;36831.44752828763;36907.815460922524;35062.12344691403;35171.648283516835;35755.821220893726;38270;39455.408168876915;29912.85043574768;30634.84682576573;32620.83689581537;32809;32851.67148328486;25246.495070098863;26028.219153425427;26065.218043458728;26128.477430451665;26373.34066648349 23:19:52 INFO - PROCESS | 3424 | |2;jquery.html;359.58288385472855;359.9532060832091;360.61954637857065;361.1963381476215;369.7522659817925;13840.169589824593;16805.243764030616;17123.657526849456;17134.742978855327;18724.531886702855;16334.509964701048;16360.83639163608;16717.916410417933;17230.224639891203;17281.30874765011;5201.947980520203;5320.521153096221;5374.892502149954;5387.865303367427;5415.566754659638;5044.2937988681615;5334.386545547273;5335.839924802262;5341.385740639818;5358.383785864637;5002.399712034561;5213.2701421800975;5218.112920803473;5320.068987927117;5327.307450031491;5073;5160.174372100465;5194.818181363653;5194.844154675366;5200.92198617021;5115.283860259567;5219.19102539107;5223.425423203445;5246.081935661244;5260.1583746600745;13152.605421837361;13176.60470185896;13581.456741730319;19775.703364449546;20295.188192472284;1987.7415935928382;2030.4111807575932;2091.4875855415366;2346.988265058681;2664.5603475426533;9296.163345298888;9526.571304291254;9555.856662150074;9596.904030959671;9619.615215391375;1862.2550979608266;1895.4882181810972;1911.827935485813;1912.4071537823181;1957.8531610129298;61902.690486547726;62345.37654623487;63031;65695.3430465694;67666.3233367665;9887.950560247153;10224;10334.276600637882;10446.477676116163;10487.423191724376;12859.742805144031;13355.131916425402;13641.317934103454;13656.590302290948;13692.178469291874;7443.106827180773;7723.420743444264;7768.65041073153;7782.338501227459;7824.804379890548;7503.062117235346;7577.696892124363;7640.579768112696;7643.656035478417;7715.4599178057;4412.0734645724115;4463.196624607602;4468.687191896536;4488.236999710057;4502.5047244803045;1755.3417468449331;1793.7130059190467;1810.9366172183911;1833.495788658103;1851.9814801852078;838.2288294768706;898.6495266845935;913.8857642794651;989.8911119776819;1037.7301901505512;16345.754813677804;16674.416395426102;16695.91652041732;16909.15454227308;16930.407435739937;882.6292956958093;885.8051228729669;896.5024411451707;915.6108653822099;944.3389627260945;9457.858132128023;9589.664361747446;9600.66397676078;9662.903370966342;9727.61089556424;404374;415011;415298;417277;422803;73238.2676173242;75293;75776.62111689406;76319;77080.61459692665;941.9952900235455;984.4093543873619;989.5893204320126;1043.660810236676;1043.8121138195047;14889.329980151137;14969.32638031313;15011;15123.319450624529;15168.469103581321;30394.84802575973;30418.391632167677;32205.838970804994;32291.51562726608;32322.676773231968;41858.58141418547;42604.78697606492;42822.78588607037;45284;45553.77223113863;7919.485233459806;7983.84032319362;7989.760307190793;8231.17688231196;8399.03411107706;7101.4673899458785;11224.719382015515;12081.852224038703;12893.613191604267;13153.736925261632;10879.51042203087;11077.501512431798;11166.609168679057;11382.94308528452;11402.429878505876;10455.895441045797;10927.672169834917;11157.218994670295;11393.202475826612;11546.711332216762;10571.841422378517;10860.837087443853;11030.393328367018;11166.609168679057;11244.718882027688;7611.847763044819;7813.218678132142;7865.331446827084;8052.677892884219;8176.713815016446;10832.729181770519;10973;11014.50434730423;11017.504212310625;11247.493862776031 23:19:52 INFO - PROCESS | 3424 | |3;mootools.html;1476.3872992708023;1490.2101886000423;1685.7218558937775;1810.6740786658413;1831.4688740265315;7715.498492597977;7767.805804854882;7848.8037799055055;7898;7977.641006154722;7935.563544005077;7978.561179135159;8012.879806802903;8017.799555011113;8065.758027259177;2303.527776805759;2312.6184179610386;2329.9515218151814;2335.824813139013;2349.166046053652;2296.644020176867;2323.7560056194025;2325.534893021394;2326.1858349577683;2331.463763334434;2250.133698526071;2270.3642979965634;2291.793738563529;2335.74306826249;2336.4158960259933;2267.9886600567056;2290.1755368067484;2293.7935585797277;2316.270374831931;2321.3964369263945;2318.686977258082;2364.3025307534317;2367.893444794988;2376.8455050421667;2383.165891937825;7654.617269136576;7719.614019299012;7725.266099720518;7730;7751.418643601753;4909.533594308535;4944.604431645495;5044.142495775727;5077.238414237857;5085.491450854922;3189.9362012759616;3285.2936618626873;3327.584051993501;3331.5002749587757;3357.6642335766473;1090.3372357155322;1107.396468924438;1110.7389763405592;1135.6990397544575;1144.8683401408778;10918.563257469692;10925.125989920867;10980.176486763525;11009.779804403946;11095;4252.957470425318;4321.805518751664;4400.691951563424;4447;4477.328400739915;8766.561671916379;8796.648134074694;8807.295416366675;8811.383203175845;8816.162464565856;4925.1873440881855;4926.3349447824085;4931.260310953386;4933.9506604933495;4969.105560999054;3862.575116737157;4381.18947994622;4454.198244316054;4464.776761161929;4491.191585514639;3591.8383672734267;3647.8176091195332;3658.1037645776955;3660.5973342932257;3685.90785230366;1102.7904698107334;1121.388843080523;1123.3989815448697;1135.7501349703052;1148.7932172209082;954.6181527388961;966.8743063401713;968.375397868371;1045.72288343589;1290.4193113099143;7153.785386438415;7158.785236442915;7211.819704507429;7217.350438460564;7298.598577078312;501.07551567358166;510.2728611728272;510.3034358101239;511.85923870935045;514.765781569385;5401.081816091195;5510.779568817283;5588.804391846266;5620.437956204429;5632.718364081779;8977.147171018743;9191.770205744777;9223;9355.90644093564;9525.14273715369;9110.088991100836;9117.133872282122;9221.170094691375;9245.121713437213;9259.35184537076;7233.095863017123;7383.852322953511;7385.670579295671;7390.667419966115;7459.888101678479;7252.673629686782;7298.37963773064;7305.926940730525;7330.486865919334;7382.335589796944;8345.998480182418;8485.854409654617;8556.614952327036;8751.387402881737;8835.11648835137;8914.662800579705;8938.1508756668;8983.955080224558;9081.545922703706;9135.314851386305;6403.391677790602;6666.600003999775;6862.519623626298;7063.71745130189;7162.176349719641;7476.289752473506;7481.925180748341;7547.245275472409;7560.546367217985;7566.394688425023;6567.9014814778775;6721.294264102395;6798.796036118924;6852.691628876612;6997.895031574429;6527.379898909596;6652.73389064432;6756.155480564929;6758.189017317954;6801.591904485746;6386.904196436964;6504.317046710216;6554.606723596599;6593.3736295051895;6872.6907289173105;6088.4824789893355;6161.291451483136;6231.283402408781;6263.592866463848;6282.591631543935;6211.316755156839;6290.308066112632;6307.306196318493;6311.179546658905;6351.396617321347 23:19:52 INFO - PROCESS | 3424 | |4;prototype.html;337.7331907792843;348.0376758263402;349.477531091019;352.4167502782895;356.0475727429126;6115.663638499881;6150.95433776258;6154.876902461948;6183.536234782392;6355.841103972403;6176.505879529638;6213.409726076027;6234.594751341159;6247.062940558919;6271.216097987752;4726.810927562893;4741.241401375781;4744.762761861911;4747.976260118695;4750.144973904696;4760.976390076133;4763.2378819388905;4767.69010014348;4769.236922092466;4769.379980602517;4621.930671039937;4707.835225767099;4732.05358928214;4737.0525894821;4740.051989602076;4695.859124226278;4719.764011799396;4730.432348118214;4732.455767586737;4742.668013239075;4157.584241575818;4160.063985603245;4161.0845613964875;4166.437530933315;4167.249895018926;5930;5930.288365396137;5963.28440587128;5968.67172305523;5981;5448.318960129984;5525.060739674265;5580.553555715533;5588.804391846306;5597.104463285855;6394.392532709385;6574.474042076622;6597.63712995785;6598;6654.70053847578;4676.812927482896;4696.53034696531;4699.365585645928;4706.952930470686;4719.669623126382;6875.449964002868;6946.0622815919705;6966.164060312795;6974;6978.4766142539;4813.302071199727;4817.325574419584;4818.084563932842;4820.132376172322;4837.806487740521;4870.220764677634;4876.463589005207;4878.658493905393;4880.219164933594;4882.048000639841;5470.510683813867;5570.248016517799;5591.944080559224;5592.692401917852;5602.943970560324;6544.7382104716235;6604.933950660528;6627.668616569153;6634.436072933758;6638.137042184581;1652;1675.2712570032074;1677.8238284980146;1707.4109432245855;1708.6241026974046;1140.2474366917795;1157.3808012713157;1160.611195249584;1166.8133098704166;1168.8363629091934;6234.906476402857;6330.52521060913;6350.206224221973;6354;6358.936410635927;6778.152730908637;6811.318868113149;6832.111825462757;6832.419244364285;6836.316368363224;6296.275928268216;6319.3364696706185;6335.303116657164;6343.889819281607;6346.30190679025;3573.76770509916;3685.4471829225295;3710.5547334320054;3716.5168528091717;3719.795411252407;7039.8240043998285;7135.82160445993;7211.963940180265;7390.334869861738;7393.963030184815;6988.44092472601;6997.195322537871;7029;7054.329838665319;7121.643917804193;7294.744683936143;7322.304381083789;7323.304286092813;7328.633568321563;7330.157031941289;6758.020087087443;6881.208661004049;6926.307369263033;6934.341237582422;6940.826479338057;6808.795736127924;6814.591124532544;6854.143232095988;6880.827979300358;6892.104026476526;7311.4516411268305;7329.120505539369;7330.780076597711;7345.926540734738;7354.558726476428;4820.34925285082;4828.758562071953;4841.394825646794;4851.611871050378;4855.75721213945;6921.792346229621;6929.133858267716;6933.029375887279;6936.0636314096955;6945.722171113099;6508.902366464412;6725.596464212163;6760.763373281911;6763.12079429671;6778.084958530732;6629.071929929717;6665.0668906352175;6665.633390163587;6711.932880671131;6723.9327606725265;6561.770338038145;6609.405153536205;6618.933810662024;6630.336966303331;6645.767398141042;6613.966930165511;6741.056252124608;6773.458123350219;6778.8644227116165;6793.830154246183;6572.638504882278;6602.801915942529;6603.240627327918;6627.900581491185;6633.568818026813 23:19:52 INFO - PROCESS | 3424 | |5;yui.html;692.5567636712505;728.2389902551835;799.3125911715927;832.0348395860799;833.958302084896;13470.25913574753;13540.255285959269;13570.59288221355;13584.660383490405;13594;13069.869301306984;13142.73714525709;13169.144005639651;13664.111832730865;13765.242911639856;820.4912953968518;822.596927505521;825.5665775467868;830.3730683334074;840.9032961209448;843.1063073142458;844.7592436155696;849.5030407211789;850.9914900851005;855.1533981358473;890.314457867445;892.3797960417512;893.4014210478995;895.9776005599847;900.288771870225;885.4996926736405;886.6674996876171;886.902440731519;887.3877024852831;888.1784349476773;637.5186734015834;643.2570381209711;643.8004218692221;645.2353960556709;646.7186773753385;13938;13988.650283742885;14131.71736565263;14223.359948802225;14243.643908902257;12761.489540418372;12882.80675789864;13018.86981130186;13074.607761767162;13543;11568.305901645928;11614.709632259177;11793.823092653616;12053.63839084829;12151.210171338835;3539.592946811098;3585.3904836177912;3586.228960773446;3620.3664358737115;3632.328019316435;48976.51023489755;49224.50775492235;49243;49417.75291123557;49583;9484.573194206278;9496.905030949601;9774.5601447935;9821.705348839547;10092.24308176875;18993.715094273597;19004.334848280243;19094.427167185007;19236.71144932827;19240.518987025436;7589.924100759032;7593.962030189814;7753.961230193813;7846.3330616897065;8001.799955001055;4243.6605071594195;4258.8296468140925;4273.230818452708;4311.741295522279;4314.094040251583;3376.69609735125;3402.557667503209;3411.3859505288788;3430.1081718753303;3444.741644376682;607.7386723708847;608.0787606775739;608.2245137449787;614.6066517428849;614.9538784591174;657.1489920552896;678.7827895073627;700.3731660164125;702.2667222917601;712.4336152758569;7674.232576742281;8115.715949941842;8116.675332986732;8390.244877961013;8407.45351552147;501.4083381609735;560.7392562458476;644.8033349828347;654.8886689262837;695.4297476069676;3733.607971163043;3770.8303126358833;3928.096537796323;3935.685145188378;3937.665298449607;55730;58914.11628825571;60155;60366.39633603608;60557;51239;51312;52105.47894521082;52254;52266.47733522616;46520.7673961628;47312.99999999931;47975.76012119917;48085.27872081922;48429;7940.682372705027;8043.316318113026;8116;8177.223163799429;8205.630746616298;32720.50919236261;33393.33213335768;33507.66492335046;33575.664243357256;34149.31701366008;41175.794121029205;42019.789901051525;44472.555274446844;45812.770936145105;46496;10880.945595271973;11048.337099774039;11078.723031923944;11206.43967801623;11802.173847830569;11474.426278685865;11498.77002459963;11922.76154476923;11945.581904633296;12202.389880506116;10640.574377025141;10751.569937202425;10966.177536684621;11086.556537738723;11496.54013839437;10176.105812435122;10202.285839991426;10289.794204116026;10386.948065259625;10421.843672345072;10667.946660266649;10717.249792514449;10762.139028877828;10933.343999359746;11059.059979901476;9271.721848344561;9561.474118923526;9727.951360243154;10221.693349199535;10606.09848162884;9548.012523282936;10028.27801756208;10053.803091574357;10082.69751907444;10096.228271236745 23:19:52 INFO - PROCESS | 3424 | __end_tp_report 23:19:52 INFO - PROCESS | 3424 | __start_cc_report 23:19:52 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,289 23:19:52 INFO - PROCESS | 3424 | __end_cc_report 23:19:52 INFO - PROCESS | 3424 | __startTimestamp1456298392842__endTimestamp 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | ------- Summary: start ------- 23:19:52 INFO - PROCESS | 3424 | Number of tests: 6 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:5334.98 Median:5549.94 stddev:577.51 (10.4%) stddev-sans-first:554.61 23:19:52 INFO - PROCESS | 3424 | Values: 3205.8 3230.7 3274.6 3285.8 3291.2 5240.1 5267.0 5362.2 5382.8 5403.2 5297.2 5361.2 5371.9 5381.5 5435.0 4869.2 4877.6 4905.1 5052.9 5075.5 4797.4 4920.8 4937.6 4991.1 5059.3 4865.3 4866.8 4905.7 4916.4 4931.2 4900.2 4901.4 4917.2 4928.1 4950.3 4846.7 4889.2 4895.4 4916.7 4928.4 5149.0 5171.0 5181.7 5185.0 5213.0 5606.9 5698.2 5700.2 5700.6 5705.1 5692.8 5710.5 5778.5 5796.2 5867.8 5288.6 5323.8 5324.5 5398.2 5409.5 5775.3 5779.6 5784.7 5786.8 5789.9 5436.6 5505.4 5585.8 5593.7 5643.2 5628.9 5633.8 5637.0 5648.0 5656.0 5538.1 5583.7 5692.7 5715.5 5722.3 5695.1 5698.0 5715.0 5717.6 5719.2 4438.1 4450.4 4464.2 4488.8 4497.8 3952.8 3955.5 3959.5 3988.9 4023.4 5270.5 5430.2 5445.1 5457.6 5530.6 5779.2 5779.2 5782.5 5784.7 5785.1 5360.0 5378.3 5390.9 5394.4 5430.2 4795.5 4830.0 4888.4 4933.9 5001.6 5958.2 6008.1 6011.6 6014.1 6029.2 5567.1 5744.9 5781.8 5784.1 5785.5 5961.5 6001.1 6018.1 6033.6 6040.5 5679.3 5685.4 5715.0 5734.0 5749.4 5603.6 5700.3 5746.9 5786.7 5807.4 5519.8 5549.3 5549.9 5560.0 5618.8 5543.2 5583.1 5597.4 5602.3 5626.6 5590.5 5617.0 5644.4 5648.0 5696.4 5634.8 5656.2 5748.8 5762.3 5765.6 5369.0 5562.1 5580.1 5582.1 5630.1 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:45740.77 Median:36600.13 stddev:80628.53 (220.3%) stddev-sans-first:80783.17 23:19:52 INFO - PROCESS | 3424 | Values: 500.4 536.2 551.3 570.8 575.7 34174.1 34709.5 34719.8 34741.0 34883.8 35568.6 35760.3 35976.8 35995.0 36027.6 8195.5 8340.7 8375.1 8376.6 8402.3 8350.5 8391.1 8438.2 8463.7 8518.1 8461.7 8467.0 8506.0 8508.8 8523.9 8373.5 8398.2 8401.0 8409.7 8416.0 8414.9 8609.7 8615.4 8654.8 8667.1 36006.5 37081.0 37273.3 37354.3 37438.0 2695.2 3001.4 3120.7 3125.6 3226.6 27539.9 28611.0 28763.6 28911.9 29119.6 3809.6 3999.4 3999.4 4002.0 4040.5 245458.0 251158.0 251576.0 253677.7 255395.0 41825.0 41921.8 42042.0 42307.0 60046.4 42520.6 43014.6 43156.1 43212.0 43247.1 15081.5 15200.7 15267.5 15311.2 15337.2 11964.2 12114.1 12121.7 12136.2 12192.8 14134.9 14143.2 14216.6 14254.2 14304.5 5689.3 5772.1 5813.3 5873.6 5892.5 895.4 919.3 934.7 1067.9 1098.1 28282.4 31315.8 32669.3 32723.5 32975.0 917.7 965.2 988.6 1018.5 1137.9 13411.6 13556.0 13831.4 13869.9 13939.0 364821.0 369668.0 370615.0 371016.0 371031.0 52201.2 52665.7 52773.5 52829.2 53639.2 1314.5 1336.8 1340.6 1349.6 1354.4 25956.5 26499.0 26845.7 27193.5 27314.9 40097.6 40667.2 40693.6 40926.0 41552.2 286600.0 288847.0 289285.0 289457.0 290540.0 31441.8 31519.4 41778.4 43654.0 43897.8 39786.2 40221.4 40718.6 40787.4 41096.0 33205.8 36126.3 36371.8 36673.6 36975.6 35686.5 36526.6 36729.4 36831.4 36907.8 35062.1 35171.6 35755.8 38270.0 39455.4 29912.9 30634.8 32620.8 32809.0 32851.7 25246.5 26028.2 26065.2 26128.5 26373.3 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:24460.85 Median:232330.79 stddev:68146.49 (29.3%) stddev-sans-first:68313.63 23:19:52 INFO - PROCESS | 3424 | Values: 359.6 360.0 360.6 361.2 369.8 13840.2 16805.2 17123.7 17134.7 18724.5 16334.5 16360.8 16717.9 17230.2 17281.3 5201.9 5320.5 5374.9 5387.9 5415.6 5044.3 5334.4 5335.8 5341.4 5358.4 5002.4 5213.3 5218.1 5320.1 5327.3 5073.0 5160.2 5194.8 5194.8 5200.9 5115.3 5219.2 5223.4 5246.1 5260.2 13152.6 13176.6 13581.5 19775.7 20295.2 1987.7 2030.4 2091.5 2347.0 2664.6 9296.2 9526.6 9555.9 9596.9 9619.6 1862.3 1895.5 1911.8 1912.4 1957.9 61902.7 62345.4 63031.0 65695.3 67666.3 9888.0 10224.0 10334.3 10446.5 10487.4 12859.7 13355.1 13641.3 13656.6 13692.2 7443.1 7723.4 7768.7 7782.3 7824.8 7503.1 7577.7 7640.6 7643.7 7715.5 4412.1 4463.2 4468.7 4488.2 4502.5 1755.3 1793.7 1810.9 1833.5 1852.0 838.2 898.6 913.9 989.9 1037.7 16345.8 16674.4 16695.9 16909.2 16930.4 882.6 885.8 896.5 915.6 944.3 9457.9 9589.7 9600.7 9662.9 9727.6 404374.0 415011.0 415298.0 417277.0 422803.0 73238.3 75293.0 75776.6 76319.0 77080.6 942.0 984.4 989.6 1043.7 1043.8 14889.3 14969.3 15011.0 15123.3 15168.5 30394.8 30418.4 32205.8 32291.5 32322.7 41858.6 42604.8 42822.8 45284.0 45553.8 7919.5 7983.8 7989.8 8231.2 8399.0 7101.5 11224.7 12081.9 12893.6 13153.7 10879.5 11077.5 11166.6 11382.9 11402.4 10455.9 10927.7 11157.2 11393.2 11546.7 10571.8 10860.8 11030.4 11166.6 11244.7 7611.8 7813.2 7865.3 8052.7 8176.7 10832.7 10973.0 11014.5 11017.5 11247.5 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:5456.56 Median:6247.44 stddev:2838.11 (45.4%) stddev-sans-first:2830.30 23:19:52 INFO - PROCESS | 3424 | Values: 1476.4 1490.2 1685.7 1810.7 1831.5 7715.5 7767.8 7848.8 7898.0 7977.6 7935.6 7978.6 8012.9 8017.8 8065.8 2303.5 2312.6 2330.0 2335.8 2349.2 2296.6 2323.8 2325.5 2326.2 2331.5 2250.1 2270.4 2291.8 2335.7 2336.4 2268.0 2290.2 2293.8 2316.3 2321.4 2318.7 2364.3 2367.9 2376.8 2383.2 7654.6 7719.6 7725.3 7730.0 7751.4 4909.5 4944.6 5044.1 5077.2 5085.5 3189.9 3285.3 3327.6 3331.5 3357.7 1090.3 1107.4 1110.7 1135.7 1144.9 10918.6 10925.1 10980.2 11009.8 11095.0 4253.0 4321.8 4400.7 4447.0 4477.3 8766.6 8796.6 8807.3 8811.4 8816.2 4925.2 4926.3 4931.3 4934.0 4969.1 3862.6 4381.2 4454.2 4464.8 4491.2 3591.8 3647.8 3658.1 3660.6 3685.9 1102.8 1121.4 1123.4 1135.8 1148.8 954.6 966.9 968.4 1045.7 1290.4 7153.8 7158.8 7211.8 7217.4 7298.6 501.1 510.3 510.3 511.9 514.8 5401.1 5510.8 5588.8 5620.4 5632.7 8977.1 9191.8 9223.0 9355.9 9525.1 9110.1 9117.1 9221.2 9245.1 9259.4 7233.1 7383.9 7385.7 7390.7 7459.9 7252.7 7298.4 7305.9 7330.5 7382.3 8346.0 8485.9 8556.6 8751.4 8835.1 8914.7 8938.2 8984.0 9081.5 9135.3 6403.4 6666.6 6862.5 7063.7 7162.2 7476.3 7481.9 7547.2 7560.5 7566.4 6567.9 6721.3 6798.8 6852.7 6997.9 6527.4 6652.7 6756.2 6758.2 6801.6 6386.9 6504.3 6554.6 6593.4 6872.7 6088.5 6161.3 6231.3 6263.6 6282.6 6211.3 6290.3 6307.3 6311.2 6351.4 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:5590.08 Median:6307.81 stddev:1692.81 (26.8%) stddev-sans-first:1651.02 23:19:52 INFO - PROCESS | 3424 | Values: 337.7 348.0 349.5 352.4 356.0 6115.7 6151.0 6154.9 6183.5 6355.8 6176.5 6213.4 6234.6 6247.1 6271.2 4726.8 4741.2 4744.8 4748.0 4750.1 4761.0 4763.2 4767.7 4769.2 4769.4 4621.9 4707.8 4732.1 4737.1 4740.1 4695.9 4719.8 4730.4 4732.5 4742.7 4157.6 4160.1 4161.1 4166.4 4167.2 5930.0 5930.3 5963.3 5968.7 5981.0 5448.3 5525.1 5580.6 5588.8 5597.1 6394.4 6574.5 6597.6 6598.0 6654.7 4676.8 4696.5 4699.4 4707.0 4719.7 6875.4 6946.1 6966.2 6974.0 6978.5 4813.3 4817.3 4818.1 4820.1 4837.8 4870.2 4876.5 4878.7 4880.2 4882.0 5470.5 5570.2 5591.9 5592.7 5602.9 6544.7 6604.9 6627.7 6634.4 6638.1 1652.0 1675.3 1677.8 1707.4 1708.6 1140.2 1157.4 1160.6 1166.8 1168.8 6234.9 6330.5 6350.2 6354.0 6358.9 6778.2 6811.3 6832.1 6832.4 6836.3 6296.3 6319.3 6335.3 6343.9 6346.3 3573.8 3685.4 3710.6 3716.5 3719.8 7039.8 7135.8 7212.0 7390.3 7394.0 6988.4 6997.2 7029.0 7054.3 7121.6 7294.7 7322.3 7323.3 7328.6 7330.2 6758.0 6881.2 6926.3 6934.3 6940.8 6808.8 6814.6 6854.1 6880.8 6892.1 7311.5 7329.1 7330.8 7345.9 7354.6 4820.3 4828.8 4841.4 4851.6 4855.8 6921.8 6929.1 6933.0 6936.1 6945.7 6508.9 6725.6 6760.8 6763.1 6778.1 6629.1 6665.1 6665.6 6711.9 6723.9 6561.8 6609.4 6618.9 6630.3 6645.8 6614.0 6741.1 6773.5 6778.9 6793.8 6572.6 6602.8 6603.2 6627.9 6633.6 23:19:52 INFO - PROCESS | 3424 | 23:19:52 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:13918.17 Median:46154.39 stddev:16178.47 (35.1%) stddev-sans-first:16193.37 23:19:52 INFO - PROCESS | 3424 | Values: 692.6 728.2 799.3 832.0 834.0 13470.3 13540.3 13570.6 13584.7 13594.0 13069.9 13142.7 13169.1 13664.1 13765.2 820.5 822.6 825.6 830.4 840.9 843.1 844.8 849.5 851.0 855.2 890.3 892.4 893.4 896.0 900.3 885.5 886.7 886.9 887.4 888.2 637.5 643.3 643.8 645.2 646.7 13938.0 13988.7 14131.7 14223.4 14243.6 12761.5 12882.8 13018.9 13074.6 13543.0 11568.3 11614.7 11793.8 12053.6 12151.2 3539.6 3585.4 3586.2 3620.4 3632.3 48976.5 49224.5 49243.0 49417.8 49583.0 9484.6 9496.9 9774.6 9821.7 10092.2 18993.7 19004.3 19094.4 19236.7 19240.5 7589.9 7594.0 7754.0 7846.3 8001.8 4243.7 4258.8 4273.2 4311.7 4314.1 3376.7 3402.6 3411.4 3430.1 3444.7 607.7 608.1 608.2 614.6 615.0 657.1 678.8 700.4 702.3 712.4 7674.2 8115.7 8116.7 8390.2 8407.5 501.4 560.7 644.8 654.9 695.4 3733.6 3770.8 3928.1 3935.7 3937.7 55730.0 58914.1 60155.0 60366.4 60557.0 51239.0 51312.0 52105.5 52254.0 52266.5 46520.8 47313.0 47975.8 48085.3 48429.0 7940.7 8043.3 8116.0 8177.2 8205.6 32720.5 33393.3 33507.7 33575.7 34149.3 41175.8 42019.8 44472.6 45812.8 46496.0 10880.9 11048.3 11078.7 11206.4 11802.2 11474.4 11498.8 11922.8 11945.6 12202.4 10640.6 10751.6 10966.2 11086.6 11496.5 10176.1 10202.3 10289.8 10386.9 10421.8 10667.9 10717.2 10762.1 10933.3 11059.1 9271.7 9561.5 9728.0 10221.7 10606.1 9548.0 10028.3 10053.8 10082.7 10096.2 23:19:52 INFO - PROCESS | 3424 | -------- Summary: end -------- 23:19:52 INFO - PROCESS | 3424 | 23:19:53 INFO - TEST-INFO | 3424: exit 0 23:19:53 INFO - TEST-OK | dromaeo_css | took 1111855ms 23:19:53 INFO - TEST-START | kraken 23:19:53 INFO - operating with platform_type : linux_ 23:19:53 INFO - Initialising browser for kraken test... 23:19:53 INFO - TEST-INFO | started process 3660 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjw6muS/profile http://localhost:57414/getInfo.html) 23:19:56 INFO - PROCESS | 3660 | 23:19:56 INFO - PROCESS | 3660 | (process:3732): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:19:57 INFO - PROCESS | 3660 | __metrics Screen width/height:1600/1200 23:19:57 INFO - PROCESS | 3660 | colorDepth:24 23:19:57 INFO - PROCESS | 3660 | Browser inner width/height: 1024/697 23:19:57 INFO - PROCESS | 3660 | __metrics 23:19:58 ERROR - PROCESS | 3660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 23:19:59 INFO - TEST-INFO | 3660: exit 0 23:19:59 INFO - Browser initialized. 23:19:59 INFO - Running cycle 1/1 for kraken test... 23:19:59 INFO - TEST-INFO | started process 3783 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjw6muS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:00 INFO - PROCESS | 3783 | 23:20:00 INFO - PROCESS | 3783 | (process:3839): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:20:11 INFO - PROCESS | 3783 | RSS: Main: 155308032 23:20:11 INFO - PROCESS | 3783 | 23:20:13 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57414/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:14 INFO - PROCESS | 3783 | RSS: Main: 162222080 23:20:14 INFO - PROCESS | 3783 | 23:20:16 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57414/tests/kraken/driver.html?testName=audio-dft) 23:20:17 INFO - PROCESS | 3783 | RSS: Main: 165064704 23:20:17 INFO - PROCESS | 3783 | 23:20:20 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57414/tests/kraken/driver.html?testName=audio-fft) 23:20:20 INFO - PROCESS | 3783 | RSS: Main: 157974528 23:20:20 INFO - PROCESS | 3783 | 23:20:22 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57414/tests/kraken/driver.html?testName=audio-oscillator) 23:20:23 INFO - PROCESS | 3783 | RSS: Main: 159178752 23:20:23 INFO - PROCESS | 3783 | 23:20:25 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57414/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:26 INFO - PROCESS | 3783 | RSS: Main: 158998528 23:20:26 INFO - PROCESS | 3783 | 23:20:29 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57414/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:30 INFO - PROCESS | 3783 | RSS: Main: 159522816 23:20:30 INFO - PROCESS | 3783 | 23:20:33 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57414/tests/kraken/driver.html?testName=imaging-desaturate) 23:20:34 INFO - PROCESS | 3783 | RSS: Main: 160350208 23:20:34 INFO - PROCESS | 3783 | 23:20:36 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57414/tests/kraken/driver.html?testName=json-parse-financial) 23:20:37 INFO - PROCESS | 3783 | RSS: Main: 161841152 23:20:37 INFO - PROCESS | 3783 | 23:20:39 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57414/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:20:39 INFO - PROCESS | 3783 | RSS: Main: 160247808 23:20:39 INFO - PROCESS | 3783 | 23:20:41 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:20:42 INFO - PROCESS | 3783 | RSS: Main: 161849344 23:20:42 INFO - PROCESS | 3783 | 23:20:44 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:20:45 INFO - PROCESS | 3783 | RSS: Main: 161308672 23:20:45 INFO - PROCESS | 3783 | 23:20:47 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:20:48 INFO - PROCESS | 3783 | RSS: Main: 161476608 23:20:48 INFO - PROCESS | 3783 | 23:20:51 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:20:51 INFO - PROCESS | 3783 | RSS: Main: 159051776 23:20:51 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | Cycle 1(1): loaded http://localhost:57414/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57414/tests/kraken/driver.html?testName=ai-astar) 23:20:53 INFO - PROCESS | 3783 | RSS: Main: 160772096 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | __start_tp_report 23:20:53 INFO - PROCESS | 3783 | _x_x_mozilla_page_load 23:20:53 INFO - PROCESS | 3783 | _x_x_mozilla_page_load_details 23:20:53 INFO - PROCESS | 3783 | |i|pagename|runs| 23:20:53 INFO - PROCESS | 3783 | |0;ai-astar;115;111;114;113;113;125;112;113;113;113 23:20:53 INFO - PROCESS | 3783 | |1;audio-beat-detection;152;136;159;168;130;163;160;127;160;130 23:20:53 INFO - PROCESS | 3783 | |2;audio-dft;164;163;163;164;162;162;167;174;166;163 23:20:53 INFO - PROCESS | 3783 | |3;audio-fft;72;74;73;73;161;73;73;75;77;92 23:20:53 INFO - PROCESS | 3783 | |4;audio-oscillator;96;96;141;98;97;97;136;96;97;143 23:20:53 INFO - PROCESS | 3783 | |5;imaging-gaussian-blur;120;116;115;116;115;115;115;117;115;115 23:20:53 INFO - PROCESS | 3783 | |6;imaging-darkroom;147;147;148;147;147;146;146;146;147;147 23:20:53 INFO - PROCESS | 3783 | |7;imaging-desaturate;97;97;97;97;96;96;97;97;96;97 23:20:53 INFO - PROCESS | 3783 | |8;json-parse-financial;56;59;56;56;57;56;57;69;53;54 23:20:53 INFO - PROCESS | 3783 | |9;json-stringify-tinderbox;68;67;67;67;68;70;69;67;67;68 23:20:53 INFO - PROCESS | 3783 | |10;stanford-crypto-aes;81;92;86;84;85;83;84;94;87;83 23:20:53 INFO - PROCESS | 3783 | |11;stanford-crypto-ccm;126;122;123;125;129;129;128;124;123;119 23:20:53 INFO - PROCESS | 3783 | |12;stanford-crypto-pbkdf2;157;162;152;154;155;140;165;152;147;143 23:20:53 INFO - PROCESS | 3783 | |13;stanford-crypto-sha256-iterative;68;69;70;69;71;69;68;70;71;68 23:20:53 INFO - PROCESS | 3783 | __end_tp_report 23:20:53 INFO - PROCESS | 3783 | __start_cc_report 23:20:53 INFO - PROCESS | 3783 | _x_x_mozilla_cycle_collect,735 23:20:53 INFO - PROCESS | 3783 | __end_cc_report 23:20:53 INFO - PROCESS | 3783 | __startTimestamp1456298453623__endTimestamp 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | ------- Summary: start ------- 23:20:53 INFO - PROCESS | 3783 | Number of tests: 14 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#0] ai-astar Cycles:10 Average:114.20 Median:113.00 stddev:3.94 (3.5%) stddev-sans-first:4.17 23:20:53 INFO - PROCESS | 3783 | Values: 115.0 111.0 114.0 113.0 113.0 125.0 112.0 113.0 113.0 113.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:159.50 stddev:15.92 (10.0%) stddev-sans-first:16.83 23:20:53 INFO - PROCESS | 3783 | Values: 152.0 136.0 159.0 168.0 130.0 163.0 160.0 127.0 160.0 130.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:3.61 (2.2%) stddev-sans-first:3.82 23:20:53 INFO - PROCESS | 3783 | Values: 164.0 163.0 163.0 164.0 162.0 162.0 167.0 174.0 166.0 163.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#3] audio-fft Cycles:10 Average:84.30 Median:73.50 stddev:27.59 (37.5%) stddev-sans-first:28.90 23:20:53 INFO - PROCESS | 3783 | Values: 72.0 74.0 73.0 73.0 161.0 73.0 73.0 75.0 77.0 92.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:96.50 stddev:20.99 (21.7%) stddev-sans-first:21.67 23:20:53 INFO - PROCESS | 3783 | Values: 96.0 96.0 141.0 98.0 97.0 97.0 136.0 96.0 97.0 143.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:115.50 stddev:1.60 (1.4%) stddev-sans-first:0.73 23:20:53 INFO - PROCESS | 3783 | Values: 120.0 116.0 115.0 116.0 115.0 115.0 115.0 117.0 115.0 115.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:20:53 INFO - PROCESS | 3783 | Values: 147.0 147.0 148.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:20:53 INFO - PROCESS | 3783 | Values: 97.0 97.0 97.0 97.0 96.0 96.0 97.0 97.0 96.0 97.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.50 stddev:4.42 (7.8%) stddev-sans-first:4.67 23:20:53 INFO - PROCESS | 3783 | Values: 56.0 59.0 56.0 56.0 57.0 56.0 57.0 69.0 53.0 54.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 23:20:53 INFO - PROCESS | 3783 | Values: 68.0 67.0 67.0 67.0 68.0 70.0 69.0 67.0 67.0 68.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:4.12 (4.8%) stddev-sans-first:3.97 23:20:53 INFO - PROCESS | 3783 | Values: 81.0 92.0 86.0 84.0 85.0 83.0 84.0 94.0 87.0 83.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:125.50 stddev:3.26 (2.6%) stddev-sans-first:3.43 23:20:53 INFO - PROCESS | 3783 | Values: 126.0 122.0 123.0 125.0 129.0 129.0 128.0 124.0 123.0 119.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.70 Median:154.50 stddev:7.83 (5.1%) stddev-sans-first:8.15 23:20:53 INFO - PROCESS | 3783 | Values: 157.0 162.0 152.0 154.0 155.0 140.0 165.0 152.0 147.0 143.0 23:20:53 INFO - PROCESS | 3783 | 23:20:53 INFO - PROCESS | 3783 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.16 (1.7%) stddev-sans-first:1.13 23:20:53 INFO - PROCESS | 3783 | Values: 68.0 69.0 70.0 69.0 71.0 69.0 68.0 70.0 71.0 68.0 23:20:53 INFO - PROCESS | 3783 | -------- Summary: end -------- 23:20:53 INFO - PROCESS | 3783 | 23:20:54 INFO - TEST-INFO | 3783: exit 0 23:20:54 INFO - TEST-OK | kraken | took 61026ms 23:20:54 INFO - SUITE-END | took 1172s 23:20:54 INFO - Completed test suite (00:19:33) 23:20:54 INFO - Working with test: dromaeo_css 23:20:54 INFO - Generating results file: dromaeo_css 23:20:54 INFO - Working with test: kraken 23:20:54 INFO - Generating results file: kraken 23:20:54 INFO - javascript benchmark 23:20:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:20:54 INFO - process_Request line: dromaeo_css 6913.18 graph.html#tests=[[72,64,43]] 23:20:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:20:54 INFO - process_Request line: kraken 1538.70 graph.html#tests=[[232,64,43]] 23:20:54 INFO - RETURN: dromaeo_css: 6913.18 23:20:54 INFO - RETURN: kraken: 1538.70 23:20:54 INFO - javascript benchmark 23:20:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3205.8397080145996, 3230.709236168744, 3274.639789623141, 3285.8028518288907, 3291.243014106757, 5240.056789777838, 5266.973665131669, 5362.249285100089, 5382.757775900089, 5403.189521571761, 5297.152455607104, 5361.222622719703, 5371.919421208685, 5381.48875856794, 5434.972825135868, 4869.196582563882, 4877.634177436688, 4905.068037072962, 5052.9242061369105, 5075.5178258065425, 4797.376341075656, 4920.8031678732805, 4937.580305674022, 4991.076650819592, 5059.266406371074, 4865.2945322928335, 4866.829660961885, 4905.656604037718, 4916.3608730864935, 4931.211006238985, 4900.191468407708, 4901.411830580353, 4917.164082106051, 4928.1129396708575, 4950.3069570260195, 4846.709197448165, 4889.168841296988, 4895.388076490439, 4916.680415772999, 4928.433230178503, 5149.047426226122, 5170.9741451292875, 5181.663191892515, 5184.9740751296, 5213.0, 5606.887862242732, 5698.202251684767, 5700.201971723962, 5700.572457065737, 5705.115707065412, 5692.800751973702, 5710.486056254916, 5778.5377169826315, 5796.1595568642315, 5867.794627188028, 5288.629795914288, 5323.760430780624, 5324.494173053554, 5398.163284690879, 5409.459054094598, 5775.306963164448, 5779.566532510079, 5784.71076446176, 5786.768529258867, 5789.913151302734, 5436.565074794007, 5505.449455054462, 5585.776568937278, 5593.692346920877, 5643.153526970905, 5628.859278517988, 5633.802816901471, 5636.971815140898, 5648.0, 5655.971720141373, 5538.113901775777, 5583.720813959286, 5692.686902220417, 5715.5427565794635, 5722.284714410699, 5695.117256825199, 5697.974364614326, 5714.971425142848, 5717.599768016199, 5719.227904232958, 4438.134563760036, 4450.443694538183, 4464.196444639996, 4488.798004089824, 4497.8425755098415, 3952.7628342299554, 3955.4660120883887, 3959.5248570171766, 3988.9202215956097, 4023.3964905264443, 5270.472952704776, 5430.239766432703, 5445.128779395278, 5457.5633949283965, 5530.557555395559, 5779.219805326311, 5779.248697669276, 5782.537397008229, 5784.65292082468, 5785.103308987113, 5359.973200133974, 5378.327709036371, 5390.946090539122, 5394.433584473652, 5430.185472179126, 4795.520447955177, 4830.0, 4888.437829649564, 4933.876653083702, 5001.649884508122, 5958.165856780054, 6008.068749343859, 6011.579189456696, 6014.127951447103, 6029.186059881948, 5567.081431563909, 5744.942550574441, 5781.768729250783, 5784.074548072288, 5785.508231800344, 5961.463468287875, 6001.129836173643, 6018.127371531016, 6033.607815491979, 6040.516758659209, 5679.318481782213, 5685.403032681509, 5714.971425142848, 5733.971330143323, 5749.425057494217, 5603.5797315202335, 5700.287464066992, 5746.885062298647, 5786.710664466844, 5807.361190268983, 5519.751611177427, 5549.334079910436, 5549.944500554942, 5560.0, 5618.831435056954, 5543.196236545759, 5583.0787919992745, 5597.384287728428, 5602.2717046783655, 5626.634268772516, 5590.496855283044, 5617.0, 5644.379118297066, 5648.039833228278, 5696.401877802771, 5634.830955071355, 5656.23640808502, 5748.827535173951, 5762.337331206965, 5765.625234359753, 5369.0, 5562.137868630369, 5580.135079062752, 5582.051051321367, 5630.127330263816], "unit": "score", "name": "dojo.html", "value": 5298.650357537715}, {"lowerIsBetter": false, "replicates": [500.35204410288674, 536.2144458368491, 551.3383939272874, 570.8116321613868, 575.7380391921677, 34174.145646358855, 34709.47935780962, 34719.82640086802, 34741.0, 34883.82558087206, 35568.64431355692, 35760.28479430416, 35976.82011589945, 35995.0, 36027.639723602755, 8195.549244791535, 8340.749777506684, 8375.078741338479, 8376.58117094146, 8402.285805706522, 8350.540720260384, 8391.076981532027, 8438.240558349748, 8463.703770368007, 8518.063013068557, 8461.703840365588, 8467.0, 8506.0, 8508.829823403528, 8523.872141917876, 8373.49759014455, 8398.160183981583, 8401.0, 8409.70566030189, 8416.0, 8414.873776893352, 8609.741707748777, 8615.353848461327, 8654.78363040929, 8667.089955554638, 36006.45990310147, 37081.0, 37273.25453490942, 37354.25291494155, 37438.0, 2695.2318589202177, 3001.3997200559975, 3120.672329405425, 3125.6092988376454, 3226.5805445291962, 27539.86230068857, 28611.0, 28763.56854647182, 28911.855440722873, 29119.56320655192, 3809.5999920008553, 3999.4000899864964, 3999.42008408782, 4001.97999010006, 4040.5151381834075, 245458.0, 251158.0, 251576.0, 253677.7316113426, 255395.0, 41825.0, 41921.79039104785, 42042.0, 42307.0, 60046.39953600495, 42520.57479425228, 43014.569854301684, 43156.13687726228, 43212.0, 43247.13505729868, 15081.54755357341, 15200.695986080216, 15267.465638702592, 15311.15788631636, 15337.233138343037, 11964.162508624313, 12114.0914431418, 12121.727218642092, 12136.211146275464, 12192.756144877052, 14134.85865141356, 14143.151410915378, 14216.644583885485, 14254.216018118896, 14304.499342522962, 5689.317281926113, 5772.105323674838, 5813.273340832396, 5873.647581145145, 5892.469677729025, 895.4358753985078, 919.3197034194648, 934.6588495199339, 1067.9213993866251, 1098.0776148035688, 28282.43435131286, 31315.84342078275, 32669.346613068083, 32723.50914736281, 32975.0, 917.6512925088424, 965.2422848064236, 988.6342053440129, 1018.4958445569342, 1137.9089672826153, 13411.597652070453, 13556.0, 13831.446742130403, 13869.930650346683, 13939.0, 364821.0, 369668.0, 370615.0, 371016.0, 371031.0, 52201.21698174455, 52665.7366713164, 52773.472265277625, 52829.2075618866, 53639.172474476705, 1314.493919840849, 1336.7727486327349, 1340.604521666111, 1349.6490912362856, 1354.4040622126035, 25956.480870382107, 26499.0, 26845.731542684323, 27193.456130876875, 27314.86342568354, 40097.59902400939, 40667.1866562673, 40693.593064068984, 40926.0, 41552.168956620095, 286600.0, 288847.0, 289285.0, 289457.0, 290540.0, 31441.8427907859, 31519.36961260808, 41778.37332439955, 43654.0, 43897.78051109724, 39786.20427591374, 40221.38007579332, 40718.59281407148, 40787.38818917778, 41096.0, 33205.83397082999, 36126.277474450886, 36371.81814091018, 36673.63326366702, 36975.63024369722, 35686.464703028956, 36526.634733652325, 36729.44905826468, 36831.44752828763, 36907.815460922524, 35062.12344691403, 35171.648283516835, 35755.821220893726, 38270.0, 39455.408168876915, 29912.85043574768, 30634.84682576573, 32620.83689581537, 32809.0, 32851.67148328486, 25246.495070098863, 26028.219153425427, 26065.218043458728, 26128.477430451665, 26373.34066648349], "unit": "score", "name": "ext.html", "value": 17545.715913391297}, {"lowerIsBetter": false, "replicates": [359.58288385472855, 359.9532060832091, 360.61954637857065, 361.1963381476215, 369.7522659817925, 13840.169589824593, 16805.243764030616, 17123.657526849456, 17134.742978855327, 18724.531886702855, 16334.509964701048, 16360.83639163608, 16717.916410417933, 17230.224639891203, 17281.30874765011, 5201.947980520203, 5320.521153096221, 5374.892502149954, 5387.865303367427, 5415.566754659638, 5044.2937988681615, 5334.386545547273, 5335.839924802262, 5341.385740639818, 5358.383785864637, 5002.399712034561, 5213.2701421800975, 5218.112920803473, 5320.068987927117, 5327.307450031491, 5073.0, 5160.174372100465, 5194.818181363653, 5194.844154675366, 5200.92198617021, 5115.283860259567, 5219.19102539107, 5223.425423203445, 5246.081935661244, 5260.1583746600745, 13152.605421837361, 13176.60470185896, 13581.456741730319, 19775.703364449546, 20295.188192472284, 1987.7415935928382, 2030.4111807575932, 2091.4875855415366, 2346.988265058681, 2664.5603475426533, 9296.163345298888, 9526.571304291254, 9555.856662150074, 9596.904030959671, 9619.615215391375, 1862.2550979608266, 1895.4882181810972, 1911.827935485813, 1912.4071537823181, 1957.8531610129298, 61902.690486547726, 62345.37654623487, 63031.0, 65695.3430465694, 67666.3233367665, 9887.950560247153, 10224.0, 10334.276600637882, 10446.477676116163, 10487.423191724376, 12859.742805144031, 13355.131916425402, 13641.317934103454, 13656.590302290948, 13692.178469291874, 7443.106827180773, 7723.420743444264, 7768.65041073153, 7782.338501227459, 7824.804379890548, 7503.062117235346, 7577.696892124363, 7640.579768112696, 7643.656035478417, 7715.4599178057, 4412.0734645724115, 4463.196624607602, 4468.687191896536, 4488.236999710057, 4502.5047244803045, 1755.3417468449331, 1793.7130059190467, 1810.9366172183911, 1833.495788658103, 1851.9814801852078, 838.2288294768706, 898.6495266845935, 913.8857642794651, 989.8911119776819, 1037.7301901505512, 16345.754813677804, 16674.416395426102, 16695.91652041732, 16909.15454227308, 16930.407435739937, 882.6292956958093, 885.8051228729669, 896.5024411451707, 915.6108653822099, 944.3389627260945, 9457.858132128023, 9589.664361747446, 9600.66397676078, 9662.903370966342, 9727.61089556424, 404374.0, 415011.0, 415298.0, 417277.0, 422803.0, 73238.2676173242, 75293.0, 75776.62111689406, 76319.0, 77080.61459692665, 941.9952900235455, 984.4093543873619, 989.5893204320126, 1043.660810236676, 1043.8121138195047, 14889.329980151137, 14969.32638031313, 15011.0, 15123.319450624529, 15168.469103581321, 30394.84802575973, 30418.391632167677, 32205.838970804994, 32291.51562726608, 32322.676773231968, 41858.58141418547, 42604.78697606492, 42822.78588607037, 45284.0, 45553.77223113863, 7919.485233459806, 7983.84032319362, 7989.760307190793, 8231.17688231196, 8399.03411107706, 7101.4673899458785, 11224.719382015515, 12081.852224038703, 12893.613191604267, 13153.736925261632, 10879.51042203087, 11077.501512431798, 11166.609168679057, 11382.94308528452, 11402.429878505876, 10455.895441045797, 10927.672169834917, 11157.218994670295, 11393.202475826612, 11546.711332216762, 10571.841422378517, 10860.837087443853, 11030.393328367018, 11166.609168679057, 11244.718882027688, 7611.847763044819, 7813.218678132142, 7865.331446827084, 8052.677892884219, 8176.713815016446, 10832.729181770519, 10973.0, 11014.50434730423, 11017.504212310625, 11247.493862776031], "unit": "score", "name": "jquery.html", "value": 8265.879944537217}, {"lowerIsBetter": false, "replicates": [1476.3872992708023, 1490.2101886000423, 1685.7218558937775, 1810.6740786658413, 1831.4688740265315, 7715.498492597977, 7767.805804854882, 7848.8037799055055, 7898.0, 7977.641006154722, 7935.563544005077, 7978.561179135159, 8012.879806802903, 8017.799555011113, 8065.758027259177, 2303.527776805759, 2312.6184179610386, 2329.9515218151814, 2335.824813139013, 2349.166046053652, 2296.644020176867, 2323.7560056194025, 2325.534893021394, 2326.1858349577683, 2331.463763334434, 2250.133698526071, 2270.3642979965634, 2291.793738563529, 2335.74306826249, 2336.4158960259933, 2267.9886600567056, 2290.1755368067484, 2293.7935585797277, 2316.270374831931, 2321.3964369263945, 2318.686977258082, 2364.3025307534317, 2367.893444794988, 2376.8455050421667, 2383.165891937825, 7654.617269136576, 7719.614019299012, 7725.266099720518, 7730.0, 7751.418643601753, 4909.533594308535, 4944.604431645495, 5044.142495775727, 5077.238414237857, 5085.491450854922, 3189.9362012759616, 3285.2936618626873, 3327.584051993501, 3331.5002749587757, 3357.6642335766473, 1090.3372357155322, 1107.396468924438, 1110.7389763405592, 1135.6990397544575, 1144.8683401408778, 10918.563257469692, 10925.125989920867, 10980.176486763525, 11009.779804403946, 11095.0, 4252.957470425318, 4321.805518751664, 4400.691951563424, 4447.0, 4477.328400739915, 8766.561671916379, 8796.648134074694, 8807.295416366675, 8811.383203175845, 8816.162464565856, 4925.1873440881855, 4926.3349447824085, 4931.260310953386, 4933.9506604933495, 4969.105560999054, 3862.575116737157, 4381.18947994622, 4454.198244316054, 4464.776761161929, 4491.191585514639, 3591.8383672734267, 3647.8176091195332, 3658.1037645776955, 3660.5973342932257, 3685.90785230366, 1102.7904698107334, 1121.388843080523, 1123.3989815448697, 1135.7501349703052, 1148.7932172209082, 954.6181527388961, 966.8743063401713, 968.375397868371, 1045.72288343589, 1290.4193113099143, 7153.785386438415, 7158.785236442915, 7211.819704507429, 7217.350438460564, 7298.598577078312, 501.07551567358166, 510.2728611728272, 510.3034358101239, 511.85923870935045, 514.765781569385, 5401.081816091195, 5510.779568817283, 5588.804391846266, 5620.437956204429, 5632.718364081779, 8977.147171018743, 9191.770205744777, 9223.0, 9355.90644093564, 9525.14273715369, 9110.088991100836, 9117.133872282122, 9221.170094691375, 9245.121713437213, 9259.35184537076, 7233.095863017123, 7383.852322953511, 7385.670579295671, 7390.667419966115, 7459.888101678479, 7252.673629686782, 7298.37963773064, 7305.926940730525, 7330.486865919334, 7382.335589796944, 8345.998480182418, 8485.854409654617, 8556.614952327036, 8751.387402881737, 8835.11648835137, 8914.662800579705, 8938.1508756668, 8983.955080224558, 9081.545922703706, 9135.314851386305, 6403.391677790602, 6666.600003999775, 6862.519623626298, 7063.71745130189, 7162.176349719641, 7476.289752473506, 7481.925180748341, 7547.245275472409, 7560.546367217985, 7566.394688425023, 6567.9014814778775, 6721.294264102395, 6798.796036118924, 6852.691628876612, 6997.895031574429, 6527.379898909596, 6652.73389064432, 6756.155480564929, 6758.189017317954, 6801.591904485746, 6386.904196436964, 6504.317046710216, 6554.606723596599, 6593.3736295051895, 6872.6907289173105, 6088.4824789893355, 6161.291451483136, 6231.283402408781, 6263.592866463848, 6282.591631543935, 6211.316755156839, 6290.308066112632, 6307.306196318493, 6311.179546658905, 6351.396617321347], "unit": "score", "name": "mootools.html", "value": 4418.449910383096}, {"lowerIsBetter": false, "replicates": [337.7331907792843, 348.0376758263402, 349.477531091019, 352.4167502782895, 356.0475727429126, 6115.663638499881, 6150.95433776258, 6154.876902461948, 6183.536234782392, 6355.841103972403, 6176.505879529638, 6213.409726076027, 6234.594751341159, 6247.062940558919, 6271.216097987752, 4726.810927562893, 4741.241401375781, 4744.762761861911, 4747.976260118695, 4750.144973904696, 4760.976390076133, 4763.2378819388905, 4767.69010014348, 4769.236922092466, 4769.379980602517, 4621.930671039937, 4707.835225767099, 4732.05358928214, 4737.0525894821, 4740.051989602076, 4695.859124226278, 4719.764011799396, 4730.432348118214, 4732.455767586737, 4742.668013239075, 4157.584241575818, 4160.063985603245, 4161.0845613964875, 4166.437530933315, 4167.249895018926, 5930.0, 5930.288365396137, 5963.28440587128, 5968.67172305523, 5981.0, 5448.318960129984, 5525.060739674265, 5580.553555715533, 5588.804391846306, 5597.104463285855, 6394.392532709385, 6574.474042076622, 6597.63712995785, 6598.0, 6654.70053847578, 4676.812927482896, 4696.53034696531, 4699.365585645928, 4706.952930470686, 4719.669623126382, 6875.449964002868, 6946.0622815919705, 6966.164060312795, 6974.0, 6978.4766142539, 4813.302071199727, 4817.325574419584, 4818.084563932842, 4820.132376172322, 4837.806487740521, 4870.220764677634, 4876.463589005207, 4878.658493905393, 4880.219164933594, 4882.048000639841, 5470.510683813867, 5570.248016517799, 5591.944080559224, 5592.692401917852, 5602.943970560324, 6544.7382104716235, 6604.933950660528, 6627.668616569153, 6634.436072933758, 6638.137042184581, 1652.0, 1675.2712570032074, 1677.8238284980146, 1707.4109432245855, 1708.6241026974046, 1140.2474366917795, 1157.3808012713157, 1160.611195249584, 1166.8133098704166, 1168.8363629091934, 6234.906476402857, 6330.52521060913, 6350.206224221973, 6354.0, 6358.936410635927, 6778.152730908637, 6811.318868113149, 6832.111825462757, 6832.419244364285, 6836.316368363224, 6296.275928268216, 6319.3364696706185, 6335.303116657164, 6343.889819281607, 6346.30190679025, 3573.76770509916, 3685.4471829225295, 3710.5547334320054, 3716.5168528091717, 3719.795411252407, 7039.8240043998285, 7135.82160445993, 7211.963940180265, 7390.334869861738, 7393.963030184815, 6988.44092472601, 6997.195322537871, 7029.0, 7054.329838665319, 7121.643917804193, 7294.744683936143, 7322.304381083789, 7323.304286092813, 7328.633568321563, 7330.157031941289, 6758.020087087443, 6881.208661004049, 6926.307369263033, 6934.341237582422, 6940.826479338057, 6808.795736127924, 6814.591124532544, 6854.143232095988, 6880.827979300358, 6892.104026476526, 7311.4516411268305, 7329.120505539369, 7330.780076597711, 7345.926540734738, 7354.558726476428, 4820.34925285082, 4828.758562071953, 4841.394825646794, 4851.611871050378, 4855.75721213945, 6921.792346229621, 6929.133858267716, 6933.029375887279, 6936.0636314096955, 6945.722171113099, 6508.902366464412, 6725.596464212163, 6760.763373281911, 6763.12079429671, 6778.084958530732, 6629.071929929717, 6665.0668906352175, 6665.633390163587, 6711.932880671131, 6723.9327606725265, 6561.770338038145, 6609.405153536205, 6618.933810662024, 6630.336966303331, 6645.767398141042, 6613.966930165511, 6741.056252124608, 6773.458123350219, 6778.8644227116165, 6793.830154246183, 6572.638504882278, 6602.801915942529, 6603.240627327918, 6627.900581491185, 6633.568818026813], "unit": "score", "name": "prototype.html", "value": 5039.817170757425}, {"lowerIsBetter": false, "replicates": [692.5567636712505, 728.2389902551835, 799.3125911715927, 832.0348395860799, 833.958302084896, 13470.25913574753, 13540.255285959269, 13570.59288221355, 13584.660383490405, 13594.0, 13069.869301306984, 13142.73714525709, 13169.144005639651, 13664.111832730865, 13765.242911639856, 820.4912953968518, 822.596927505521, 825.5665775467868, 830.3730683334074, 840.9032961209448, 843.1063073142458, 844.7592436155696, 849.5030407211789, 850.9914900851005, 855.1533981358473, 890.314457867445, 892.3797960417512, 893.4014210478995, 895.9776005599847, 900.288771870225, 885.4996926736405, 886.6674996876171, 886.902440731519, 887.3877024852831, 888.1784349476773, 637.5186734015834, 643.2570381209711, 643.8004218692221, 645.2353960556709, 646.7186773753385, 13938.0, 13988.650283742885, 14131.71736565263, 14223.359948802225, 14243.643908902257, 12761.489540418372, 12882.80675789864, 13018.86981130186, 13074.607761767162, 13543.0, 11568.305901645928, 11614.709632259177, 11793.823092653616, 12053.63839084829, 12151.210171338835, 3539.592946811098, 3585.3904836177912, 3586.228960773446, 3620.3664358737115, 3632.328019316435, 48976.51023489755, 49224.50775492235, 49243.0, 49417.75291123557, 49583.0, 9484.573194206278, 9496.905030949601, 9774.5601447935, 9821.705348839547, 10092.24308176875, 18993.715094273597, 19004.334848280243, 19094.427167185007, 19236.71144932827, 19240.518987025436, 7589.924100759032, 7593.962030189814, 7753.961230193813, 7846.3330616897065, 8001.799955001055, 4243.6605071594195, 4258.8296468140925, 4273.230818452708, 4311.741295522279, 4314.094040251583, 3376.69609735125, 3402.557667503209, 3411.3859505288788, 3430.1081718753303, 3444.741644376682, 607.7386723708847, 608.0787606775739, 608.2245137449787, 614.6066517428849, 614.9538784591174, 657.1489920552896, 678.7827895073627, 700.3731660164125, 702.2667222917601, 712.4336152758569, 7674.232576742281, 8115.715949941842, 8116.675332986732, 8390.244877961013, 8407.45351552147, 501.4083381609735, 560.7392562458476, 644.8033349828347, 654.8886689262837, 695.4297476069676, 3733.607971163043, 3770.8303126358833, 3928.096537796323, 3935.685145188378, 3937.665298449607, 55730.0, 58914.11628825571, 60155.0, 60366.39633603608, 60557.0, 51239.0, 51312.0, 52105.47894521082, 52254.0, 52266.47733522616, 46520.7673961628, 47312.99999999931, 47975.76012119917, 48085.27872081922, 48429.0, 7940.682372705027, 8043.316318113026, 8116.0, 8177.223163799429, 8205.630746616298, 32720.50919236261, 33393.33213335768, 33507.66492335046, 33575.664243357256, 34149.31701366008, 41175.794121029205, 42019.789901051525, 44472.555274446844, 45812.770936145105, 46496.0, 10880.945595271973, 11048.337099774039, 11078.723031923944, 11206.43967801623, 11802.173847830569, 11474.426278685865, 11498.77002459963, 11922.76154476923, 11945.581904633296, 12202.389880506116, 10640.574377025141, 10751.569937202425, 10966.177536684621, 11086.556537738723, 11496.54013839437, 10176.105812435122, 10202.285839991426, 10289.794204116026, 10386.948065259625, 10421.843672345072, 10667.946660266649, 10717.249792514449, 10762.139028877828, 10933.343999359746, 11059.059979901476, 9271.721848344561, 9561.474118923526, 9727.951360243154, 10221.693349199535, 10606.09848162884, 9548.012523282936, 10028.27801756208, 10053.803091574357, 10082.69751907444, 10096.228271236745], "unit": "score", "name": "yui.html", "value": 6378.557412061639}], "name": "dromaeo_css", "value": 6913.180839713749}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 111.0, 114.0, 113.0, 113.0, 125.0, 112.0, 113.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.2}, {"lowerIsBetter": true, "replicates": [152.0, 136.0, 159.0, 168.0, 130.0, 163.0, 160.0, 127.0, 160.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 164.0, 162.0, 162.0, 167.0, 174.0, 166.0, 163.0], "unit": "score", "name": "audio-dft", "value": 164.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 73.0, 73.0, 161.0, 73.0, 73.0, 75.0, 77.0, 92.0], "unit": "score", "name": "audio-fft", "value": 84.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 141.0, 98.0, 97.0, 97.0, 136.0, 96.0, 97.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 117.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 56.0, 56.0, 57.0, 56.0, 57.0, 69.0, 53.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 70.0, 69.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [81.0, 92.0, 86.0, 84.0, 85.0, 83.0, 84.0, 94.0, 87.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.9}, {"lowerIsBetter": true, "replicates": [126.0, 122.0, 123.0, 125.0, 129.0, 129.0, 128.0, 124.0, 123.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [157.0, 162.0, 152.0, 154.0, 155.0, 140.0, 165.0, 152.0, 147.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 70.0, 69.0, 71.0, 69.0, 68.0, 70.0, 71.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1538.7}]} 23:20:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1538.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6913.18"}}} 23:20:54 INFO - Return code: 0 23:20:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:20:55 ERROR - # TBPL SUCCESS # 23:20:55 INFO - Running post-action listener: _resource_record_post_action 23:20:55 INFO - Running post-run listener: _resource_record_post_run 23:20:56 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 10375168; Write bytes: 428277760; Read time: 3400; Write time: 412808 23:20:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5701632; Read time: 0; Write time: 2744 23:20:56 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8609792; Write bytes: 362299392; Read time: 3052; Write time: 373384 23:20:56 INFO - Running post-run listener: _upload_blobber_files 23:20:56 INFO - Blob upload gear active. 23:20:56 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:20:56 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 23:20:56 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:20:56 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:20:56 INFO - (blobuploader) - INFO - Open directory for files ... 23:20:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:20:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:20:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:57 INFO - (blobuploader) - INFO - Done attempting. 23:20:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:20:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:20:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:20:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:20:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:20:58 INFO - (blobuploader) - INFO - Done attempting. 23:20:58 INFO - (blobuploader) - INFO - Iteration through files over. 23:20:58 INFO - Return code: 0 23:20:58 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:20:58 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:20:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb93fbfc9f63792d8fdf5a2813de1511c0ff2a0d15adce32c46c6108ad4833b48077631534c08df648ef500a15c43acb94fddc6ea3c076005d91e16b35e8584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/783f260286a46ba974fed8f94bb6f07c5ddbbc5776219aaab5a759dd3a55160fa077562a1ea824f6c5bade938ca38ec6a89b0bedd5c7df4c0edd189cf866b052"} 23:20:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:20:58 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:20:58 INFO - Contents: 23:20:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb93fbfc9f63792d8fdf5a2813de1511c0ff2a0d15adce32c46c6108ad4833b48077631534c08df648ef500a15c43acb94fddc6ea3c076005d91e16b35e8584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/783f260286a46ba974fed8f94bb6f07c5ddbbc5776219aaab5a759dd3a55160fa077562a1ea824f6c5bade938ca38ec6a89b0bedd5c7df4c0edd189cf866b052"} 23:20:58 INFO - Running post-run listener: copy_logs_to_upload_dir 23:20:58 INFO - Copying logs to upload dir... 23:20:58 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:20:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.638287 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-02-23 23:20:58.161055) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 23:20:58.164568) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb93fbfc9f63792d8fdf5a2813de1511c0ff2a0d15adce32c46c6108ad4833b48077631534c08df648ef500a15c43acb94fddc6ea3c076005d91e16b35e8584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/783f260286a46ba974fed8f94bb6f07c5ddbbc5776219aaab5a759dd3a55160fa077562a1ea824f6c5bade938ca38ec6a89b0bedd5c7df4c0edd189cf866b052"} build_url:https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/DbDfDKLDR9-xWsISOcp-Kw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bb93fbfc9f63792d8fdf5a2813de1511c0ff2a0d15adce32c46c6108ad4833b48077631534c08df648ef500a15c43acb94fddc6ea3c076005d91e16b35e8584b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/783f260286a46ba974fed8f94bb6f07c5ddbbc5776219aaab5a759dd3a55160fa077562a1ea824f6c5bade938ca38ec6a89b0bedd5c7df4c0edd189cf866b052"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-23 23:20:58.188772) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:20:58.189063) ========= 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=8887e36bb8e381bfd44124ac000001a8-1456296085.359945-1515042251 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004370 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-23 23:20:58.273899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 23:20:58.274217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-23 23:20:58.274488) ========= ========= Total master_lag: 0.24 =========