builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1456146017.16 results: success (0) buildid: 20160222023004 builduid: b927a7d6dafa4b5dae767d6770399ef9 revision: 758daaf1723f377d853d2547b072d49559d8b494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.158164) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.158589) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.158901) ========= 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006628 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.185058) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.185344) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.208935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.209238) ========= 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035519 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.258745) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.259022) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.259351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.259615) ========= 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-22 05:00:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 83.5M=0s 2016-02-22 05:00:17 (83.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123001 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.396166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.396456) ========= 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.234003 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.644485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:17.644780) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 758daaf1723f377d853d2547b072d49559d8b494 --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 758daaf1723f377d853d2547b072d49559d8b494 --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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-22 05:00:17,764 truncating revision to first 12 chars 2016-02-22 05:00:17,764 Setting DEBUG logging. 2016-02-22 05:00:17,764 attempt 1/10 2016-02-22 05:00:17,764 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/758daaf1723f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 05:00:18,020 unpacking tar archive at: fx-team-758daaf1723f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.545338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:18.201926) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:18.202248) ========= echo 758daaf1723f377d853d2547b072d49559d8b494 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'758daaf1723f377d853d2547b072d49559d8b494'] 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 758daaf1723f377d853d2547b072d49559d8b494 program finished with exit code 0 elapsedTime=0.003848 script_repo_revision: '758daaf1723f377d853d2547b072d49559d8b494' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:18.250314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:18.250582) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 05:00:18.259981) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-02-22 05:00:18.260276) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:18 INFO - MultiFileLogger online at 20160222 05:00:18 in /builds/slave/test-pgo 05:00:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:00:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:00:18 INFO - {'append_to_log': False, 05:00:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:00:18 INFO - 'blob_upload_branch': 'Fx-Team', 05:00:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:00:18 INFO - 'branch': 'Fx-Team', 05:00:18 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:18 INFO - 'config_files': ('talos/linux_config.py',), 05:00:18 INFO - 'default_actions': ('clobber', 05:00:18 INFO - 'read-buildbot-config', 05:00:18 INFO - 'download-and-extract', 05:00:18 INFO - 'populate-webroot', 05:00:18 INFO - 'create-virtualenv', 05:00:18 INFO - 'install', 05:00:18 INFO - 'run-tests'), 05:00:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:18 INFO - 'download_minidump_stackwalk': True, 05:00:18 INFO - 'download_symbols': 'ondemand', 05:00:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:18 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:18 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:18 INFO - 'installer_path': 'installer.exe', 05:00:18 INFO - 'log_level': 'info', 05:00:18 INFO - 'log_name': 'talos', 05:00:18 INFO - 'log_to_console': True, 05:00:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:18 INFO - 'opt_config_files': (), 05:00:18 INFO - 'pip_index': False, 05:00:18 INFO - 'sps_profile': False, 05:00:18 INFO - 'sps_profile_interval': 0, 05:00:18 INFO - 'suite': 'dromaeojs', 05:00:18 INFO - 'system_bits': '32', 05:00:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:18 INFO - 'title': 'talos-linux64-ix-021', 05:00:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:18 INFO - 'use_talos_json': True, 05:00:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:00:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:18 INFO - 'work_dir': 'build'} 05:00:18 INFO - ##### 05:00:18 INFO - ##### Running clobber step. 05:00:18 INFO - ##### 05:00:18 INFO - Running pre-action listener: _resource_record_pre_action 05:00:18 INFO - Running main action method: clobber 05:00:18 INFO - rmtree: /builds/slave/test-pgo/build 05:00:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:00:24 INFO - Running post-action listener: _resource_record_post_action 05:00:24 INFO - ##### 05:00:24 INFO - ##### Running read-buildbot-config step. 05:00:24 INFO - ##### 05:00:24 INFO - Running pre-action listener: _resource_record_pre_action 05:00:24 INFO - Running main action method: read_buildbot_config 05:00:24 INFO - Using buildbot properties: 05:00:24 INFO - { 05:00:24 INFO - "project": "", 05:00:24 INFO - "product": "firefox", 05:00:24 INFO - "script_repo_revision": "production", 05:00:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:00:24 INFO - "repository": "", 05:00:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:00:24 INFO - "buildid": "20160222023004", 05:00:24 INFO - "pgo_build": "True", 05:00:24 INFO - "basedir": "/builds/slave/test-pgo", 05:00:24 INFO - "buildnumber": 656, 05:00:24 INFO - "slavename": "talos-linux64-ix-021", 05:00:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:00:24 INFO - "platform": "ubuntu64_hw", 05:00:24 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:00:24 INFO - "branch": "fx-team", 05:00:24 INFO - "repo_path": "integration/fx-team", 05:00:24 INFO - "revision": "758daaf1723f377d853d2547b072d49559d8b494", 05:00:24 INFO - "stage_platform": "linux64-pgo", 05:00:24 INFO - "builduid": "b927a7d6dafa4b5dae767d6770399ef9", 05:00:24 INFO - "slavebuilddir": "test" 05:00:24 INFO - } 05:00:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 05:00:24 INFO - Running post-action listener: _resource_record_post_action 05:00:24 INFO - ##### 05:00:24 INFO - ##### Running download-and-extract step. 05:00:24 INFO - ##### 05:00:24 INFO - Running pre-action listener: _resource_record_pre_action 05:00:24 INFO - Running main action method: download_and_extract 05:00:24 INFO - mkdir: /builds/slave/test-pgo/build/tests 05: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')]} 05:00:24 INFO - https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:00:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/test_packages.json 05:00:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/test_packages.json 05:00:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:00:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:00:26 INFO - Downloaded 1448 bytes. 05:00:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:00:26 INFO - Using the following test package requirements: 05:00:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:00:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:00:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'jsshell-linux-x86_64.zip'], 05:00:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:00:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:00:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:00:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:00:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 05:00:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 05:00:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:00:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05: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')]} 05:00:26 INFO - https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:29 INFO - Downloaded 23366288 bytes. 05:00:29 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'] 05:00:29 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 05:00:31 INFO - Return code: 0 05:00:31 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 05:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:31 INFO - https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 05:00:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:32 INFO - Downloaded 23366288 bytes. 05:00:32 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'] 05:00:32 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 05:00:33 INFO - Return code: 0 05: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')]} 05:00:33 INFO - https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:00:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 05:00:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:34 INFO - Downloaded 10707015 bytes. 05:00:34 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'] 05:00:34 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 05:00:34 INFO - Return code: 0 05:00:34 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')]} 05:00:34 INFO - https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/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 05:00:36 INFO - Downloaded 56561038 bytes. 05:00:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:36 INFO - mkdir: /builds/slave/test-pgo/properties 05:00:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:00:36 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:00:36 INFO - Contents: 05:00:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 05:00:36 INFO - Running post-action listener: _resource_record_post_action 05:00:36 INFO - Running post-action listener: set_extra_try_arguments 05:00:36 INFO - ##### 05:00:36 INFO - ##### Running populate-webroot step. 05:00:36 INFO - ##### 05:00:36 INFO - Running pre-action listener: _resource_record_pre_action 05:00:36 INFO - Running main action method: populate_webroot 05:00:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:36 INFO - '--tppagecycles', 05:00:36 INFO - '7'], 05:00:36 INFO - 'tests': ['tsvgm']}}, 05:00:36 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:00:36 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:36 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:00:36 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'tests': ['damp', 'tps']}, 05:00:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['damp', 'tps']}, 05:00:36 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:00:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:36 INFO - 'other': {'tests': ['a11yr', 05:00:36 INFO - 'ts_paint', 05:00:36 INFO - 'tpaint', 05:00:36 INFO - 'sessionrestore', 05:00:36 INFO - 'sessionrestore_no_auto_restore']}, 05:00:36 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['a11yr', 05:00:36 INFO - 'ts_paint', 05:00:36 INFO - 'tpaint', 05:00:36 INFO - 'sessionrestore', 05:00:36 INFO - 'sessionrestore_no_auto_restore']}, 05:00:36 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['a11yr', 05:00:36 INFO - 'ts_paint', 05:00:36 INFO - 'tpaint', 05:00:36 INFO - 'sessionrestore', 05:00:36 INFO - 'sessionrestore_no_auto_restore']}, 05:00:36 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['a11yr', 05:00:36 INFO - 'ts_paint', 05:00:36 INFO - 'tpaint', 05:00:36 INFO - 'sessionrestore', 05:00:36 INFO - 'sessionrestore_no_auto_restore']}, 05:00:36 INFO - 'other_l64': {'tests': ['a11yr', 05:00:36 INFO - 'ts_paint', 05:00:36 INFO - 'tpaint', 05:00:36 INFO - 'sessionrestore', 05:00:36 INFO - 'sessionrestore_no_auto_restore']}, 05:00:36 INFO - 'other_nol64': {'tests': ['a11yr', 05:00:36 INFO - 'ts_paint', 05:00:36 INFO - 'tpaint', 05:00:36 INFO - 'sessionrestore', 05:00:36 INFO - 'sessionrestore_no_auto_restore']}, 05:00:36 INFO - 'svgr': {'tests': ['tsvgx', 05:00:36 INFO - 'tsvgr_opacity', 05:00:36 INFO - 'tart', 05:00:36 INFO - 'tscrollx', 05:00:36 INFO - 'cart']}, 05:00:36 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['tsvgx', 05:00:36 INFO - 'tsvgr_opacity', 05:00:36 INFO - 'tart', 05:00:36 INFO - 'tscrollx', 05:00:36 INFO - 'cart']}, 05:00:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'tests': ['tp5o']}, 05:00:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'talos_options': ['--e10s'], 05:00:36 INFO - 'tests': ['tp5o']}, 05:00:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'talos_options': ['--xperf_path', 05:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:36 INFO - 'tests': ['tp5n']}, 05:00:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:36 INFO - 'talos_options': ['--e10s', 05:00:36 INFO - '--xperf_path', 05:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:36 INFO - 'tests': ['tp5n']}}, 05:00:36 INFO - 'talos.zip': {'path': '', 05:00:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:36 INFO - Running post-action listener: _resource_record_post_action 05:00:36 INFO - ##### 05:00:36 INFO - ##### Running create-virtualenv step. 05:00:36 INFO - ##### 05:00:36 INFO - Running pre-action listener: _resource_record_pre_action 05:00:36 INFO - Running main action method: create_virtualenv 05:00:36 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:00:36 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 05:00:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:36 INFO - Using real prefix '/usr' 05:00:36 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:00:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:39 INFO - Installing pip.................done. 05:00:39 INFO - Return code: 0 05:00:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:39 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:39 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 05:00:39 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 05:00:39 INFO - Using env: {'DISPLAY': ':0', 05:00:39 INFO - 'HOME': '/home/cltbld', 05:00:39 INFO - 'LANG': 'en_US.UTF-8', 05:00:39 INFO - 'LANGUAGE': 'en_US:en', 05:00:39 INFO - 'LOGNAME': 'cltbld', 05:00:39 INFO - 'MAIL': '/var/mail/cltbld', 05:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:39 INFO - 'MOZ_NO_REMOTE': '1', 05:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:39 INFO - 'NO_EM_RESTART': '1', 05:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:39 INFO - 'SHELL': '/bin/bash', 05:00:39 INFO - 'SHLVL': '1', 05:00:39 INFO - 'TERM': 'linux', 05:00:39 INFO - 'TMOUT': '86400', 05:00:39 INFO - 'USER': 'cltbld', 05:00:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:39 INFO - '_': '/tools/buildbot/bin/python'} 05:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:39 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 05:00:39 INFO - Cleaning up... 05:00:39 INFO - Return code: 0 05:00:39 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:39 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:39 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 05:00:39 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 05:00:39 INFO - Using env: {'DISPLAY': ':0', 05:00:39 INFO - 'HOME': '/home/cltbld', 05:00:39 INFO - 'LANG': 'en_US.UTF-8', 05:00:39 INFO - 'LANGUAGE': 'en_US:en', 05:00:39 INFO - 'LOGNAME': 'cltbld', 05:00:39 INFO - 'MAIL': '/var/mail/cltbld', 05:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:39 INFO - 'MOZ_NO_REMOTE': '1', 05:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:39 INFO - 'NO_EM_RESTART': '1', 05:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:39 INFO - 'SHELL': '/bin/bash', 05:00:39 INFO - 'SHLVL': '1', 05:00:39 INFO - 'TERM': 'linux', 05:00:39 INFO - 'TMOUT': '86400', 05:00:39 INFO - 'USER': 'cltbld', 05:00:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:39 INFO - '_': '/tools/buildbot/bin/python'} 05:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:40 INFO - Downloading/unpacking psutil>=0.7.1 05:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:41 INFO - Installing collected packages: psutil 05:00:41 INFO - Running setup.py install for psutil 05:00:42 INFO - building 'psutil._psutil_linux' extension 05:00:42 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 05:00:42 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 05:00:42 INFO - building 'psutil._psutil_posix' extension 05:00:42 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 05:00:42 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 05:00:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:42 INFO - Successfully installed psutil 05:00:42 INFO - Cleaning up... 05:00:42 INFO - Return code: 0 05:00:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:00:42 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')]} 05:00:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:42 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')]} 05:00:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:42 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:42 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 05:00:42 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 05:00:42 INFO - Using env: {'DISPLAY': ':0', 05:00:42 INFO - 'HOME': '/home/cltbld', 05:00:42 INFO - 'LANG': 'en_US.UTF-8', 05:00:42 INFO - 'LANGUAGE': 'en_US:en', 05:00:42 INFO - 'LOGNAME': 'cltbld', 05:00:42 INFO - 'MAIL': '/var/mail/cltbld', 05:00:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:42 INFO - 'MOZ_NO_REMOTE': '1', 05:00:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:42 INFO - 'NO_EM_RESTART': '1', 05:00:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:42 INFO - 'SHELL': '/bin/bash', 05:00:42 INFO - 'SHLVL': '1', 05:00:42 INFO - 'TERM': 'linux', 05:00:42 INFO - 'TMOUT': '86400', 05:00:42 INFO - 'USER': 'cltbld', 05:00:42 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:42 INFO - '_': '/tools/buildbot/bin/python'} 05:00:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:00:42 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 05:00:42 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 05:00:42 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 05:00:42 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 05:00:42 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 05:00:42 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 05:00:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05: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) 05:00:46 INFO - Installing collected packages: mozsystemmonitor 05:00:46 INFO - Running setup.py install for mozsystemmonitor 05:00:47 INFO - Successfully installed mozsystemmonitor 05:00:47 INFO - Cleaning up... 05:00:47 INFO - Return code: 0 05:00:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:47 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:47 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 05:00:47 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 05:00:47 INFO - Using env: {'DISPLAY': ':0', 05:00:47 INFO - 'HOME': '/home/cltbld', 05:00:47 INFO - 'LANG': 'en_US.UTF-8', 05:00:47 INFO - 'LANGUAGE': 'en_US:en', 05:00:47 INFO - 'LOGNAME': 'cltbld', 05:00:47 INFO - 'MAIL': '/var/mail/cltbld', 05:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:47 INFO - 'MOZ_NO_REMOTE': '1', 05:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:47 INFO - 'NO_EM_RESTART': '1', 05:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:47 INFO - 'SHELL': '/bin/bash', 05:00:47 INFO - 'SHLVL': '1', 05:00:47 INFO - 'TERM': 'linux', 05:00:47 INFO - 'TMOUT': '86400', 05:00:47 INFO - 'USER': 'cltbld', 05:00:47 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:47 INFO - '_': '/tools/buildbot/bin/python'} 05:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:48 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:00:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:50 INFO - Downloading docopt-0.6.1.tar.gz 05:00:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:51 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:51 INFO - Running setup.py install for blobuploader 05:00:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:00:51 INFO - Running setup.py install for requests 05:00:51 INFO - Running setup.py install for docopt 05:00:51 INFO - Successfully installed blobuploader requests docopt 05:00:51 INFO - Cleaning up... 05:00:51 INFO - Return code: 0 05:00:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:51 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 05:00:51 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 05:00:51 INFO - Using env: {'DISPLAY': ':0', 05:00:51 INFO - 'HOME': '/home/cltbld', 05:00:51 INFO - 'LANG': 'en_US.UTF-8', 05:00:51 INFO - 'LANGUAGE': 'en_US:en', 05:00:51 INFO - 'LOGNAME': 'cltbld', 05:00:51 INFO - 'MAIL': '/var/mail/cltbld', 05:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:51 INFO - 'MOZ_NO_REMOTE': '1', 05:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:51 INFO - 'NO_EM_RESTART': '1', 05:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:51 INFO - 'SHELL': '/bin/bash', 05:00:51 INFO - 'SHLVL': '1', 05:00:51 INFO - 'TERM': 'linux', 05:00:51 INFO - 'TMOUT': '86400', 05:00:51 INFO - 'USER': 'cltbld', 05:00:51 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:51 INFO - '_': '/tools/buildbot/bin/python'} 05:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:51 INFO - Running setup.py (path:/tmp/pip-ZyaipI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:51 INFO - Running setup.py (path:/tmp/pip-ma0wXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:52 INFO - Running setup.py (path:/tmp/pip-IIHZCi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:52 INFO - Running setup.py (path:/tmp/pip-xFcSGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:52 INFO - Running setup.py (path:/tmp/pip-nwsu3K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:52 INFO - Running setup.py (path:/tmp/pip-xf2coz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:52 INFO - Running setup.py (path:/tmp/pip-KMl23r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:52 INFO - Running setup.py (path:/tmp/pip-4fGB_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:52 INFO - Running setup.py (path:/tmp/pip-masscP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:52 INFO - Running setup.py (path:/tmp/pip-actWPA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:52 INFO - Running setup.py (path:/tmp/pip-RUoEOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:52 INFO - Running setup.py (path:/tmp/pip-SRmzmt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:52 INFO - Running setup.py (path:/tmp/pip-kpPhMO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:52 INFO - Running setup.py (path:/tmp/pip-PNQSok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:52 INFO - Running setup.py (path:/tmp/pip-RHl1ei-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:52 INFO - Running setup.py (path:/tmp/pip-2ssRAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:53 INFO - Running setup.py (path:/tmp/pip-LnVGwe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:00:53 INFO - Running setup.py install for manifestparser 05:00:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Running setup.py install for mozcrash 05:00:53 INFO - Running setup.py install for mozdebug 05:00:53 INFO - Running setup.py install for mozdevice 05:00:53 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Running setup.py install for mozfile 05:00:53 INFO - Running setup.py install for mozhttpd 05:00:53 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Running setup.py install for mozinfo 05:00:53 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Running setup.py install for mozInstall 05:00:53 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:00:53 INFO - Running setup.py install for mozleak 05:00:53 INFO - Running setup.py install for mozlog 05:00:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Running setup.py install for moznetwork 05:00:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Running setup.py install for mozprocess 05:00:54 INFO - Running setup.py install for mozprofile 05:00:54 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Running setup.py install for mozrunner 05:00:54 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Running setup.py install for mozscreenshot 05:00:54 INFO - Running setup.py install for moztest 05:00:54 INFO - Running setup.py install for mozversion 05:00:54 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:00:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:00:54 INFO - Cleaning up... 05:00:54 INFO - Return code: 0 05:00:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:54 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')]} 05:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:54 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')]} 05:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:54 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:54 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 05:00:54 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 05:00:54 INFO - Using env: {'DISPLAY': ':0', 05:00:54 INFO - 'HOME': '/home/cltbld', 05:00:54 INFO - 'LANG': 'en_US.UTF-8', 05:00:54 INFO - 'LANGUAGE': 'en_US:en', 05:00:54 INFO - 'LOGNAME': 'cltbld', 05:00:54 INFO - 'MAIL': '/var/mail/cltbld', 05:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:54 INFO - 'MOZ_NO_REMOTE': '1', 05:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:54 INFO - 'NO_EM_RESTART': '1', 05:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:54 INFO - 'SHELL': '/bin/bash', 05:00:54 INFO - 'SHLVL': '1', 05:00:54 INFO - 'TERM': 'linux', 05:00:54 INFO - 'TMOUT': '86400', 05:00:54 INFO - 'USER': 'cltbld', 05:00:54 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:54 INFO - '_': '/tools/buildbot/bin/python'} 05:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:55 INFO - Running setup.py (path:/tmp/pip-Qo_6Zj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:55 INFO - Running setup.py (path:/tmp/pip-awWDRC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:55 INFO - Running setup.py (path:/tmp/pip-U0yxtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:55 INFO - Running setup.py (path:/tmp/pip-Rsrysg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:55 INFO - Running setup.py (path:/tmp/pip-nEGC5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:55 INFO - Running setup.py (path:/tmp/pip-PqI2Dw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:55 INFO - Running setup.py (path:/tmp/pip-6nf8qe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:55 INFO - Running setup.py (path:/tmp/pip-yhTF52-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:55 INFO - Running setup.py (path:/tmp/pip-MP3DsX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:55 INFO - Running setup.py (path:/tmp/pip-AO_Y3W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:55 INFO - Running setup.py (path:/tmp/pip-XugQLD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:55 INFO - Running setup.py (path:/tmp/pip-e0CPas-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:00:55 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)) 05:00:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:55 INFO - Running setup.py (path:/tmp/pip-9mxY4d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:00:56 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)) 05:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:56 INFO - Running setup.py (path:/tmp/pip-hxv0T8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:00:56 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)) 05:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:56 INFO - Running setup.py (path:/tmp/pip-wlySBd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:00:56 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)) 05:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:56 INFO - Running setup.py (path:/tmp/pip-GqHD9w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:00:56 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)) 05:00:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:56 INFO - Running setup.py (path:/tmp/pip-irDDCu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:00:56 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)) 05:00:56 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)) 05:00:56 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)) 05:00:56 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)) 05:00:56 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)) 05:00:56 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)) 05:00:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:00:56 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 05:00:56 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 05:00:56 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 05:00:56 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 05:00:56 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 05:00:56 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 05:00:58 INFO - Downloading blessings-1.6.tar.gz 05:00:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:00:58 INFO - Installing collected packages: blessings 05:00:58 INFO - Running setup.py install for blessings 05:00:58 INFO - Successfully installed blessings 05:00:58 INFO - Cleaning up... 05:00:58 INFO - Return code: 0 05:00:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:00:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:00:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:00:58 INFO - Reading from file tmpfile_stdout 05:00:58 INFO - Current package versions: 05:00:58 INFO - argparse == 1.2.1 05:00:58 INFO - blessings == 1.6 05:00:58 INFO - blobuploader == 1.2.4 05:00:58 INFO - docopt == 0.6.1 05:00:58 INFO - manifestparser == 1.1 05:00:58 INFO - mozInstall == 1.12 05:00:58 INFO - mozcrash == 0.16 05:00:58 INFO - mozdebug == 0.1 05:00:58 INFO - mozdevice == 0.48 05:00:58 INFO - mozfile == 1.2 05:00:58 INFO - mozhttpd == 0.7 05:00:58 INFO - mozinfo == 0.9 05:00:58 INFO - mozleak == 0.1 05:00:58 INFO - mozlog == 3.1 05:00:58 INFO - moznetwork == 0.27 05:00:58 INFO - mozprocess == 0.22 05:00:58 INFO - mozprofile == 0.28 05:00:58 INFO - mozrunner == 6.11 05:00:58 INFO - mozscreenshot == 0.1 05:00:58 INFO - mozsystemmonitor == 0.0 05:00:58 INFO - moztest == 0.7 05:00:58 INFO - mozversion == 1.4 05:00:58 INFO - psutil == 3.1.1 05:00:58 INFO - requests == 1.2.3 05:00:58 INFO - wsgiref == 0.1.2 05:00:58 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:00:58 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')]} 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:58 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')]} 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:58 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:58 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 05:00:58 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 05:00:58 INFO - Using env: {'DISPLAY': ':0', 05:00:58 INFO - 'HOME': '/home/cltbld', 05:00:58 INFO - 'LANG': 'en_US.UTF-8', 05:00:58 INFO - 'LANGUAGE': 'en_US:en', 05:00:58 INFO - 'LOGNAME': 'cltbld', 05:00:58 INFO - 'MAIL': '/var/mail/cltbld', 05:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:58 INFO - 'MOZ_NO_REMOTE': '1', 05:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:58 INFO - 'NO_EM_RESTART': '1', 05:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:58 INFO - 'SHELL': '/bin/bash', 05:00:58 INFO - 'SHLVL': '1', 05:00:58 INFO - 'TERM': 'linux', 05:00:58 INFO - 'TMOUT': '86400', 05:00:58 INFO - 'USER': 'cltbld', 05:00:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:58 INFO - '_': '/tools/buildbot/bin/python'} 05:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 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)) 05:00:58 INFO - Cleaning up... 05:00:58 INFO - Return code: 0 05:00:58 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:00:58 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')]} 05:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:58 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')]} 05:00:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:58 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:00:58 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 05:00:58 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 05:00:58 INFO - Using env: {'DISPLAY': ':0', 05:00:58 INFO - 'HOME': '/home/cltbld', 05:00:58 INFO - 'LANG': 'en_US.UTF-8', 05:00:58 INFO - 'LANGUAGE': 'en_US:en', 05:00:58 INFO - 'LOGNAME': 'cltbld', 05:00:58 INFO - 'MAIL': '/var/mail/cltbld', 05:00:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:58 INFO - 'MOZ_NO_REMOTE': '1', 05:00:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:58 INFO - 'NO_EM_RESTART': '1', 05:00:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:58 INFO - 'SHELL': '/bin/bash', 05:00:58 INFO - 'SHLVL': '1', 05:00:58 INFO - 'TERM': 'linux', 05:00:58 INFO - 'TMOUT': '86400', 05:00:58 INFO - 'USER': 'cltbld', 05:00:58 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:00:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:58 INFO - '_': '/tools/buildbot/bin/python'} 05:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:58 INFO - Downloading/unpacking jsonschema 05:00:58 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 05:00:58 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 05:00:58 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 05:00:58 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 05:00:58 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 05:00:58 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 05:01:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:00 INFO - Downloading/unpacking functools32 (from jsonschema) 05: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 05: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 05: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 05: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 05: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 05: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 05:01:00 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:01 INFO - warning: no files found matching '*.txt' 05:01:01 INFO - no previously-included directories found matching 'build' 05:01:01 INFO - no previously-included directories found matching 'dist' 05:01:01 INFO - no previously-included directories found matching '.git*' 05:01:01 INFO - Installing collected packages: jsonschema, functools32 05:01:01 INFO - Running setup.py install for functools32 05:01:01 INFO - warning: no files found matching '*.txt' 05:01:01 INFO - no previously-included directories found matching 'build' 05:01:01 INFO - no previously-included directories found matching 'dist' 05:01:01 INFO - no previously-included directories found matching '.git*' 05:01:01 INFO - Successfully installed jsonschema functools32 05:01:01 INFO - Cleaning up... 05:01:01 INFO - Return code: 0 05:01:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:01 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 0x7f9bf4f6ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, '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': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', '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 05:01:01 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 05:01:01 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 05:01:01 INFO - Using env: {'DISPLAY': ':0', 05:01:01 INFO - 'HOME': '/home/cltbld', 05:01:01 INFO - 'LANG': 'en_US.UTF-8', 05:01:01 INFO - 'LANGUAGE': 'en_US:en', 05:01:01 INFO - 'LOGNAME': 'cltbld', 05:01:01 INFO - 'MAIL': '/var/mail/cltbld', 05:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:01 INFO - 'MOZ_NO_REMOTE': '1', 05:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:01 INFO - 'NO_EM_RESTART': '1', 05:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:01 INFO - 'SHELL': '/bin/bash', 05:01:01 INFO - 'SHLVL': '1', 05:01:01 INFO - 'TERM': 'linux', 05:01:01 INFO - 'TMOUT': '86400', 05:01:01 INFO - 'USER': 'cltbld', 05:01:01 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:01 INFO - '_': '/tools/buildbot/bin/python'} 05:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:01 INFO - Downloading/unpacking flake8 05: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 05: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 05: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 05: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 05: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 05: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 05:01:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:01:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:01:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 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 05:01:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:03 INFO - no previously-included directories found matching 'docs/_build' 05:01:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:01:04 INFO - Running setup.py install for pep8 05:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:04 INFO - no previously-included directories found matching 'docs/_build' 05:01:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:01:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:01:04 INFO - Cleaning up... 05:01:04 INFO - Return code: 0 05:01:04 INFO - Running post-action listener: _resource_record_post_action 05:01:04 INFO - Running post-action listener: _start_resource_monitoring 05:01:04 INFO - Starting resource monitoring. 05:01:04 INFO - ##### 05:01:04 INFO - ##### Running install step. 05:01:04 INFO - ##### 05:01:04 INFO - Running pre-action listener: _resource_record_pre_action 05:01:04 INFO - Running main action method: install 05:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:01:04 INFO - Reading from file tmpfile_stdout 05:01:04 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:01:04 INFO - Reading from file tmpfile_stdout 05:01:04 INFO - Output received: 05:01:04 INFO - Usage: mozinstall [options] installer 05:01:04 INFO - Options: 05:01:04 INFO - -h, --help show this help message and exit 05:01:04 INFO - -d DEST, --destination=DEST 05:01:04 INFO - Directory to install application into. [default: 05:01:04 INFO - "/builds/slave/test-pgo"] 05:01:04 INFO - --app=APP Application being installed. [default: firefox] 05:01:04 INFO - mkdir: /builds/slave/test-pgo/build/application 05:01:04 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'] 05:01:04 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 05:01:20 INFO - Reading from file tmpfile_stdout 05:01:20 INFO - Output received: 05:01:20 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:01:20 INFO - Running post-action listener: _resource_record_post_action 05:01:20 INFO - ##### 05:01:20 INFO - ##### Running run-tests step. 05:01:20 INFO - ##### 05:01:20 INFO - Running pre-action listener: _resource_record_pre_action 05:01:20 INFO - Running main action method: run_tests 05:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:01:20 INFO - Python 2.7.3 05:01:20 INFO - Return code: 0 05:01:20 INFO - grabbing minidump binary from tooltool 05:01:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:20 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 0x26e48c0>, '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 0x26e57c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26e5c50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:01:20 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 05:01:20 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 05:01:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:20 INFO - Return code: 0 05:01:20 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:01:20 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:01:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:01:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:01:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:01:21 INFO - Return code: 0 05:01:21 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:01:21 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:01:21 INFO - Using env: {'DISPLAY': ':0', 05:01:21 INFO - 'HOME': '/home/cltbld', 05:01:21 INFO - 'LANG': 'en_US.UTF-8', 05:01:21 INFO - 'LANGUAGE': 'en_US:en', 05:01:21 INFO - 'LOGNAME': 'cltbld', 05:01:21 INFO - 'MAIL': '/var/mail/cltbld', 05:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:21 INFO - 'MOZ_NO_REMOTE': '1', 05:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:21 INFO - 'NO_EM_RESTART': '1', 05:01:21 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:21 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:21 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:01:21 INFO - 'SHELL': '/bin/bash', 05:01:21 INFO - 'SHLVL': '1', 05:01:21 INFO - 'TERM': 'linux', 05:01:21 INFO - 'TMOUT': '86400', 05:01:21 INFO - 'USER': 'cltbld', 05:01:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420', 05:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:21 INFO - '_': '/tools/buildbot/bin/python'} 05:01:21 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:01:22 INFO - mozversion application_buildid: 20160222023004 05:01:22 INFO - mozversion application_changeset: 758daaf1723f377d853d2547b072d49559d8b494 05:01:22 INFO - mozversion application_display_name: Nightly 05:01:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:22 INFO - mozversion application_name: Firefox 05:01:22 INFO - mozversion application_remotingname: firefox 05:01:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:01:22 INFO - mozversion application_vendor: Mozilla 05:01:22 INFO - mozversion application_version: 47.0a1 05:01:22 INFO - mozversion platform_buildid: 20160222023004 05:01:22 INFO - mozversion platform_changeset: 758daaf1723f377d853d2547b072d49559d8b494 05:01:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:01:22 INFO - mozversion platform_version: 47.0a1 05:01:22 INFO - using testdate: 1456146082 05:01:22 INFO - actual date: 1456146082 05:01:22 INFO - starting webserver on 'localhost:55150' 05:01:22 INFO - SUITE-START | Running 2 tests 05:01:22 INFO - TEST-START | dromaeo_css 05:01:22 INFO - operating with platform_type : linux_ 05:01:22 INFO - Initialising browser for dromaeo_css test... 05:01:22 INFO - TEST-INFO | started process 11211 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgZR9nH/profile http://localhost:55150/getInfo.html) 05:01:27 INFO - PROCESS | 11211 | __metrics Screen width/height:1600/1200 05:01:27 INFO - PROCESS | 11211 | colorDepth:24 05:01:27 INFO - PROCESS | 11211 | Browser inner width/height: 1024/697 05:01:27 INFO - PROCESS | 11211 | __metrics 05:01:28 INFO - PROCESS | 11211 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:29 INFO - TEST-INFO | 11211: exit 0 05:01:29 INFO - Browser initialized. 05:01:29 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:29 INFO - TEST-INFO | started process 11306 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgZR9nH/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:41 INFO - PROCESS | 11306 | RSS: Main: 147140608 05:01:41 INFO - PROCESS | 11306 | 05:02:32 INFO - PROCESS | 11306 | 1456146152875 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] 05:04:40 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:55150/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55150/tests/dromaeo/cssquery-ext.html) 05:04:41 INFO - PROCESS | 11306 | RSS: Main: 264622080 05:04:41 INFO - PROCESS | 11306 | 05:07:44 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:55150/tests/dromaeo/cssquery-ext.html (next: http://localhost:55150/tests/dromaeo/cssquery-jquery.html) 05:07:44 INFO - PROCESS | 11306 | RSS: Main: 233758720 05:07:44 INFO - PROCESS | 11306 | 05:10:46 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:55150/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55150/tests/dromaeo/cssquery-mootools.html) 05:10:47 INFO - PROCESS | 11306 | RSS: Main: 237273088 05:10:47 INFO - PROCESS | 11306 | 05:13:49 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:55150/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55150/tests/dromaeo/cssquery-prototype.html) 05:13:49 INFO - PROCESS | 11306 | RSS: Main: 215347200 05:13:49 INFO - PROCESS | 11306 | 05:16:52 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:55150/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55150/tests/dromaeo/cssquery-yui.html) 05:16:53 INFO - PROCESS | 11306 | RSS: Main: 190013440 05:16:53 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | Cycle 1(1): loaded http://localhost:55150/tests/dromaeo/cssquery-yui.html (next: http://localhost:55150/tests/dromaeo/cssquery-dojo.html) 05:19:55 INFO - PROCESS | 11306 | RSS: Main: 302080000 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | __start_tp_report 05:19:55 INFO - PROCESS | 11306 | _x_x_mozilla_page_load 05:19:55 INFO - PROCESS | 11306 | _x_x_mozilla_page_load_details 05:19:55 INFO - PROCESS | 11306 | |i|pagename|runs| 05:19:55 INFO - PROCESS | 11306 | |0;dojo.html;3128.327409606935;3147.6537580866116;3191.6967888050626;3199;3223.8710451581937;4978.45237023928;5022.623303252252;5111.207762796763;5154.742262886854;5158.200478925773;5122.795088196477;5131.589472842173;5203.271541984125;5235.79056837727;5278.102722537168;4595.609373203281;4689.320048592952;4694.319323698071;4739.289106634015;4860.951390486085;4789;4789.832355867546;4815.879603009917;4842.636802239828;4863.68386054907;4559.954400456003;4649.67452278339;4723.031778485402;4775.355327030841;4776.617870570381;4665.09030739006;4700.271457924027;4701.177293973575;4705.670603057787;4747.643926705511;4558.749268790215;4681.297805329194;4739.3838800956;4753;4760.714357138548;4966.230234313651;4983.227599722049;4997.150484417622;5007.799688012475;5032.6980381177245;5468.535174510172;5477.589180811416;5480.862978425571;5485.396606373296;5525.723713814293;5441.428649991733;5492.505674489315;5495.6153069285165;5496;5534;5184.11869982104;5189;5199.2461093141665;5206.505381988705;5206.531412172884;5625.971870140623;5630.23991761107;5645.887082258414;5646.181303710939;5650.858728531737;5301.310829592128;5393.191021346829;5426.511613954763;5426.972865135728;5485.588580856372;5450.127979523258;5486.067368547357;5507.256520369779;5511.255980442669;5539.972300138554;5379.892402151935;5495.642783219078;5498.780048798083;5502.944970550243;5568.832935011957;5466.152746324246;5492.286002819608;5505.9724701376235;5515.365732940683;5523.171524271392;4312.417823593837;4315.050688848449;4329.848455304113;4331.068820203672;4359.411479450297;3781.0736369589076;3889.4360317753767;3897.7661340319673;3900.9804950975063;3935.7835319057153;5016.122178618727;5040.924386134211;5060.089183946925;5060.3927528696795;5091.363579552556;5349.518543331119;5491.890162196733;5500.697461639648;5506.587005974568;5542.75057622408;5022.874428139326;5073.467285934998;5076.3908330999775;5099.617528685363;5126.359205099363;4743.691660042086;4802.639802014793;4804.927926081042;4816.349792778;4847.030593881238;5604.8318550443555;5737.053386191315;5795;5800.332961709373;5831.416858314219;5553.861153471195;5577.358603760619;5577.8047768327915;5578.414266501959;5595;5778.653280803165;5787.797427090031;5788.13178023283;5789.652620842763;5794.3626201117;5302.602304827231;5437.510624043855;5474.753636086465;5516.310461192351;5520.503154716095;5527.695976721319;5537.944620553743;5540.058190107772;5554.389017208023;5559.610827242054;5260.815871444481;5399.05516534597;5418.972905135449;5427.104527753035;5484.040292948798;5366.060939335679;5380.838574842761;5399.055165346127;5412;5455.754491047833;5202.375714914235;5235.816746413857;5244.265802787689;5245.659032162897;5284.26020357158;5297.099493086262;5372.925414916954;5376.516113549799;5400.135978243462;5454.8090816822805;5115.232715092617;5176.611754118381;5194.402643696023;5200.063988482109;5250.501202385767 05:19:55 INFO - PROCESS | 11306 | |1;ext.html;514.1773162939297;517.9976744998428;533.1203514201568;542.476510167688;586.5014737473145;28189.71810281899;39587.80206098973;39804.203915921666;39806.40290395643;39880;43796.56203437965;44321.77839110808;44332.33501497472;44461.333080003824;44464.3330350045;8660.177283158106;8871.733847984571;8875.556222188898;8876.778080547974;8877.911220887805;8709.129087091273;8854.247388971946;8878.067802880701;8884.822303553925;8885.155910188554;8817.382783205177;8886.777830554256;8904;8905.064968178345;8906.376553641248;8760.561971901412;8832.514211718353;8844.646214151426;8847.46915185091;8853.468791872509;8755.649774009033;8870.645174193025;8891.110888911122;8892.377533572653;8892.421992570462;40446.59553404458;40822.591774082175;40879.795601021804;40886;40944.795276023724;3211.0366889932925;3249.6425393206728;3307.6526964668606;3421.606515250753;3927.8428862845453;30094.398112037856;30643;31469.213269668213;31745.365092698015;32073;3684.8157592120288;3732.64539868712;3808.4668146459517;3824.139568597071;3961.623645753649;278847;279971;280489;280968;282346;57631.71184144053;58708.706456467444;58715.70642146847;58799;58854;61455.692721537;61532;61637;61736;61744;16320.75518867218;16700.74948875768;16756.581085472717;16769.81992340988;16779.161041947853;12502;12584.685382865502;12614.873851261553;12641.178323408949;12671.556495522796;18844.969733626196;19551.315703950295;19771.505712357306;19848;19943.301984430476;7406.555606663617;7556.773296801105;7633.465657404039;7638.961805191049;7754.3796496280165;941.6562954521687;984.4683870709737;1011.2466212671607;1034.6482196053378;1039.9740006499899;28573.857130714212;29253.707462925526;29567.852160739058;29735;29812.701872980993;902.4675441489553;1045.4668119259081;1051.8054159980275;1058.169337070396;1060.4962642744636;13636.318184090955;13701.520446784314;13741.24423156716;15797.21013949298;15957.601059973593;330180;330372;336020;336168;336574.80551167007;45802;52787;53560;53598.73200633972;53606;1366.9863301366859;1384.605387464588;1399.4542128569865;1400.6848459096418;1401.3763875075697;26125.73874261309;28064.43871122607;28291.575626366033;28799.85600071986;28983.420331593672;42805.57194428016;42996.57003429926;43421;43448;43528.12943741044;204738;206191.50467962227;206492;206590;284356;31373.52939705952;31772.710684057358;31774.205644859063;31775.841120795172;31803.20491987719;37154;37721.62278377181;37984.050398740255;38140.80929595445;38407.42388864225;32462.83768581142;32906.341873162884;33274.33451331008;33511.83244083764;33737;32472;35263.64736352706;36062.45906311355;36223;36858.26283474369;33065;33351.332973339915;33537.49693754644;33647;33681.66318336883;30021.849890750407;31448.37103257876;32776.34447311088;32844.34311313808;32960.67039329576;24565.93613272354;24909.875450622632;25003;25322.74677253204;25352.732363381387 05:19:55 INFO - PROCESS | 11306 | |2;jquery.html;368.50252159584545;368.7031939288873;372.49154903556644;374.25896724485517;378.5949034533047;13840.100393474442;16494.01035937843;17104.57238569035;17599.1200439978;17871.463856084305;16784.580385490368;16793.83206167938;17131.400400985967;17764;17870.28518859244;5511.751971161298;5572.888542229153;5609;5675.886482270373;5681.176229446728;4000.599940006005;5419.268398766175;5926.703664816763;6140.140380346755;6153.630782153063;6086.7565297388055;6091.78678746244;6092.756289748427;6116.8470788230425;6129.172561704179;5905.557083218754;6058.182145410379;6122.387761223887;6123.785667501638;6124.418180272867;5446.400895901447;5461.754221060062;5463.371712253102;5465.781368745245;5468.425815289377;20503.2823851166;21040.737555746706;21209.151633934624;21479.892600536896;21520.56958860814;2116.9047392867205;2355.3051849704207;2391.545606334791;2417.8791060447084;2473.6042233242597;13247;13282.667933301647;13291.069625126245;13370.866291337059;13812;1833.7891142518647;1837.3477415517566;1888.1597689028388;1956.1099699636632;2069.265410779182;71273;71631.92552111775;74245.25754742492;74808.62595687041;75507.62246188789;15197.164155971306;15689.293981770848;15844.603884902739;15846.445374412071;15873.603159920864;24414.26757197287;24635;24723;24840.627390589154;24858.751412485643;9147.176754092163;9317.44095354281;9378.624855005859;9442.57508412123;9521.28590355726;8142.796430089295;8187.5087494750505;8205;8211.671533138608;8260.173982601691;7822.374210063182;7881.330086942559;7896.249856263646;7931.968844050237;7970.561619110888;2562.9102981395563;2950.4836653585535;3019.805933793871;3057.556654285116;3085.876564937377;797.8962734844549;918.6463211663557;934.509382574154;992.2558081438921;1015.4009134610615;16128.596785080466;16956;16979.575510612085;17258.395956141474;17466.912665436845;394.48125714685096;443.1579998003754;446.76991349455056;457.38024976157493;886.9911300887038;5156.5561642740095;5593.692346920959;5610.5231055360755;5754.798582049608;5809.8547536311935;325741;331264;332013;395900;427796;59967.679892133914;63382.68308658427;72422.63788681023;75407;78869.21130788734;474.11814025911775;480.0255481372749;481.458359345736;482.1538200458173;483.8620993016973;9848.310618256653;10420.374777513374;10452.581896724047;10753.46232688378;10794.352338859693;33128.66871331256;35054.29891402209;35167.47248791219;35845.28309433849;36318;49336.25995610141;49388.50611493839;49561;49641.50358496369;49697;7775.961120194363;7801.141874393698;7803.414743894117;7929.563873986986;8021.839563208587;12293.56972505958;12618.36908154607;12657.556985505464;12672.176308539916;12969.935150324189;10344.53449594755;10646.467676615983;10747.623833165802;10874.184436167161;10934.90650934932;10840.241183117107;11083.33499989971;11151.16366272549;11203.439828008404;11266.605668801552;11319.320840749582;11494.310341379543;11529.135314851588;11897.643070707893;11908.285502869856;6668.566543174678;7723.227677232232;7737.458377913492;7910.367170626451;7931.051562732318;8869.822603548022;11052.668419947415;11106.944465277622;11107.888921111009;11292 05:19:55 INFO - PROCESS | 11306 | |3;mootools.html;1225.2219840401353;1467.0464198271125;1484.5843163914105;1651.7274649682804;1798.685230084735;7685.615719214038;7877.133515313318;7906.525608463489;7924.286814186722;7937.761867143995;7722.961385193066;7840.176781437938;7919.56442395668;7939.92060079399;7945.92054079459;1969.2123150739676;2279.1567120165564;2281.338411860567;2312.09828167015;2334.4163959010248;2270.738865030518;2273.1702928431087;2278.214016164429;2279.2706333973133;2280.8289378296613;2277.8974946127382;2278.396225000376;2280.2133264023887;2281.7718228177214;2286.0969916882823;2215.102883332253;2243.2821497120926;2262.592733308004;2263.4907145892207;2265.3430505153488;2255.5263394687136;2258.153192552793;2274.1926616051396;2312.2485192312565;2312.9653055204185;8003.599820008976;8043.517388956681;8055.5972201389695;8059.516429014219;8083.353331733506;4676.205045142334;4801.615870730333;4801.639877009238;4808.038392321515;4808.495108013678;3141.2461009357817;3158.699923507263;3159.8262095584732;3236.158598764315;3267.738580913521;1063.8351055586397;1071.1484369925927;1078.654830454255;1083.214669364712;1095.1622009162998;11201.999999999918;11322.490487928064;11343.376114313709;11349.886501134966;11366.147538934612;4298.806553705091;4305.590968857953;4345.869623911288;4355.455568053993;4358.084802191512;9594.1365277124;9596.376235544667;9601.759956001157;9605.327627066177;9623.903760962441;4173.6661067114555;4634.86095417138;4844.685095468783;4848.393950756155;4852.636052296021;4171.791410429466;4255.255330317244;4265.317549192115;4283.2290187765875;4292.957070429318;3655.926881462356;3675.852965881388;3690.5755838078426;3707.0361705956648;3729.254149170177;1121.8429419881222;1132.7960967026015;1136.778328225988;1154.9836144193057;1167.8481797366287;1316.3023597493343;1319.9868001319865;1339.5512503311304;1340.2896464873634;1341.0545565376385;7566.772996810105;7682.539047657158;7683.615819209017;7685.4620176587105;7692;457.8420444946488;464.7443905851768;464.7885212228428;465.40428251837704;478.89943111946883;5623.325200975827;5628.521575666033;5630.831075067673;5660.20757093999;5660.377358490563;9364.578593963288;9389.577469013911;9505.097015783489;9546.90453095474;9585.760355991017;9309.487978161265;9333.160015598629;9426.528673566294;9429.575669094907;9475.147236748726;7355.521891077063;7414.666340014604;7455.739049133254;7463.552186868806;7516.436267279976;7439.181690013986;7461.664225109775;7502.549847009197;7523.774286771406;7543.660535275816;8351.582420879053;8482.872756908528;8688.609012594323;8697.260732837527;8706.434081784664;8681.696140635047;8865.069167737553;8865.157810008039;8885.155910188521;8895.555222238992;6148.754049837957;6840.794776156524;7016.964915175391;7053.259407762316;7121.893171602326;7721.03487064117;7726.575038372944;7728.961355193188;7806.687732490636;7815.765527034198;6821.590704557742;7067.646617669199;7133.072700548895;7138.964305178441;7256;7063.36429721307;7072.222055573986;7141.178764442156;7184.676689548878;7196.640167991684;7251.057362543047;7267.709291628275;7272.89090663651;7273.781786546412;7289.380402665833;6588.769393071411;6592.340765923561;6607.273199947906;6616.470682345497;6621.9337806621315;6832.282610326043;6842.521023528305;6846.931530684828;6847;6861.416779573792 05:19:55 INFO - PROCESS | 11306 | |4;prototype.html;328.07973633956755;328.73865277104716;330.42670965874214;343.71986830732965;344.8844637046589;5805.506531944785;5813.622114562556;5833.3874943130995;5841.678707671076;5867.4719275265215;5531.004419204542;5648.4633959773855;5747;5818.330891947417;5836.9124463133085;4496.4829044659955;4496.8875778105485;4509.323601459774;4510.932336014962;4514.458265008204;4349.826006959718;4505.549445055484;4512.9097418051615;4518.774061296938;4520.186366454037;4399.648028157756;4488.416505854234;4506.909861802762;4522.841700540482;4533.773311334437;4512.661550383735;4513.526079761627;4513.774311284439;4517.367568540407;4530.252508336121;4010.5387880393546;4011.7392369495888;4014.5383280922774;4020.5376381716183;4024.255512730125;5584.664920104766;5590.357108932443;5596.972015139939;5597;5606.467385598403;5237.47625237477;5244.5279924806955;5249.055170069386;5250.579953603741;5269.1832765921345;5974.701264936736;6155.661438620874;6158.9692051539905;6163.3220345762375;6170.321264660884;4244.257254980366;4251.766152861592;4253.638440732541;4267.359896015622;4267.893302667427;6382.234131904202;6457.677116144174;6464.999999999953;6471;6475.611463312216;4402.427684401007;4403.427554417905;4404.977975110168;4405.405270288534;4407.228734971367;4446.73319600825;4456.286994080931;4458.665600080007;4459.375687403701;4463.330500424962;5080.485376600656;5144.6913185209005;5159.561437277798;5197.1164901966;5198.350206224222;6139.84650383744;6203.7828675996125;6216.533759968021;6244.406781355764;6249.0938813871735;1482.17739154768;1516.8103987001625;1531.3032570180542;1567.1694002178863;1569.0664054887325;1011.1051719228535;1020.4846552491093;1032.488917985587;1047.2041248650928;1059.2902755154066;5773.336066352424;5787.160861675034;5832.125181222766;5832.795852145155;5839.562032847553;6334.5565810393755;6351.301356850743;6401.263854656681;6424.775132870327;6439.54923155384;5790.073588225863;5791.971040144772;5793.333766616893;5794.362620111784;5808.854778630568;3375.409303371949;3379.1552111972005;3381.425157723193;3381.4758712399616;3381.560397148355;6243.562950593415;6381.298057213796;6400.807975760735;6411.1024456576115;6510.674466276667;6331.778387756406;6332.240131184288;6383.106365108889;6390.105385246069;6395.232572091286;6472.0291956206;6477.740890364427;6477.935220647733;6481.773137940149;6481.870362592722;6196.597221180609;6203.2245969253845;6203.627782333075;6208.379162083756;6214.9689251553455;6126.693665316628;6200.100985357189;6200.534959877937;6205.22434695663;6218.751249949952;6542.934570654233;6798.96600517014;6804.863902721819;6805.625690587065;6808;4398.318260669601;4454.220511410425;4456.598906098467;4461.397711309061;4473.552644735631;6254.937450625435;6322.051692246016;6492.091107244895;6501.577397469149;6501.9674901625185;6291.716872740646;6299.685015749103;6313.147725057059;6319.9052014218905;6320.431161195331;6297;6300.0234963580715;6300.149479820166;6305.5901366411035;6308.463780578519;6129.693515324305;6144.446999770043;6145.938540614537;6147;6150.292716337678;6153.353897840662;6293.3391993841815;6312.4634406076;6327.620342779263;6333.683315834282;6097.115918191926;6139.631622102509;6171.074338849208;6177.351378105234;6197 05:19:55 INFO - PROCESS | 11306 | |5;yui.html;738.8965544823723;739.9223081576434;752.6725874244704;820.4379999700204;830.829679915617;13400.731985360288;13722.862771372284;13801.792973105412;13881.930590347034;13897.652558686037;11762.823557646641;13803.37884795184;14174.787378189336;14277.357518911647;14383.568492945202;672.4284358295434;680.051328396886;681.5263391942602;826.8842362069315;834.0366876257932;678.0168755304803;818.8607936650753;834.670305229434;835.761807884753;837;869.1482347299618;869.9217070463657;870.3559366069127;870.5125129927229;873.7640836974014;711.5161690050763;845.6490556419079;856.4090777363631;864.2222000199807;871.6556960000796;630.3853742600927;631.2235949781794;633.1357696743958;633.556510442692;634.1375729008545;14068.944829137856;14115.78826317606;14155.646108847259;14175.574732758034;14177.291135443187;13313.933430332883;13538.203492377264;13839.654008649764;13963.930180349033;13996.860031399658;10470.895291047069;10482.266241363108;10827.455155054598;10922;10982.121430285559;3620.31214069326;3655.342038433081;3666.211764470652;3788.3181027415053;3789.052736815796;49597.25604115941;51004.23493647598;52858.47141528574;53400.46599533994;53424.46575534234;10615.84076238857;10793.406362649972;10821.783564328827;11083.334999900031;11120.610778622871;18751.718724219147;18774.436766897015;18775.0612469376;18787.24851005972;18815.529611759815;7833.608319583998;8050;8105.27052565272;8113.918860811316;8120.918790812017;4451.399061126771;4581.587657110809;4614.238650622677;4638.7216766993415;4643.164230438486;3229.450993331139;3257.2833976525126;3259.3155437357946;3270.378628060661;3281.392942305681;592.1059200607115;592.1443514122138;593.4303069053757;595.7497850902545;607.9240094988127;648.9870202595922;654.3603429955253;661.5798967655477;662.8243515468405;665.8501837086617;8633.525156116348;8943.642254309885;8986.68546600866;9006.506903666053;9182.127697868691;613.8061470440041;615.1971676961608;618.7463140112623;626.1828314050208;629.9496040316856;3672.081979505124;3822.827972741233;3832.5400951885954;4005.818283606343;4010.6991975601945;56102.43897561054;57538.71230643904;57901;57906;58004.70997644985;49626.503734962185;50012.499875001515;50104.749476252386;51846.74076629593;51984.74007629938;45148.3227751584;45498.31752523781;47994.5200547997;48257.27614085792;49320.50679493159;8401.579921004048;8568.957155214184;8654.394192406471;8705.956470217609;8829.64681412762;37038;37847.2430551393;38488.80755596204;40653;40906.38640420337;45172.32241516445;45832.7708361456;45896;46150.769246154894;48699;11232.3260604364;11275.718107047389;11326;11504.424778760862;11648.592299269485;11090.112790976542;11242.775144497227;11329.603463879055;11347.886521134684;12131;11078.486227402771;11279.15406344511;11280.605178818701;11615.6515304541;11903.523859045541;10658.253922225369;10734.745703402374;10771.569137234736;11026.889731102907;11181.776364472827;10959.726006849893;11183.105351571692;11372.090232781524;11613.245139065933;11750.529978800752;9735.951320243354;9849.803003939738;9958.253131015348;10037.648682296085;10046.196304295785;9141.5886285116;9145.222656074307;9375.156235938799;9977.10206081456;10008.64969726056 05:19:55 INFO - PROCESS | 11306 | __end_tp_report 05:19:55 INFO - PROCESS | 11306 | __start_cc_report 05:19:55 INFO - PROCESS | 11306 | _x_x_mozilla_cycle_collect,939 05:19:55 INFO - PROCESS | 11306 | __end_cc_report 05:19:55 INFO - PROCESS | 11306 | __startTimestamp1456147195982__endTimestamp 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | ------- Summary: start ------- 05:19:55 INFO - PROCESS | 11306 | Number of tests: 6 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | [#0] dojo.html Cycles:165 Average:5125.78 Median:5250.50 stddev:543.60 (10.4%) stddev-sans-first:522.19 05:19:55 INFO - PROCESS | 11306 | Values: 3128.3 3147.7 3191.7 3199.0 3223.9 4978.5 5022.6 5111.2 5154.7 5158.2 5122.8 5131.6 5203.3 5235.8 5278.1 4595.6 4689.3 4694.3 4739.3 4861.0 4789.0 4789.8 4815.9 4842.6 4863.7 4560.0 4649.7 4723.0 4775.4 4776.6 4665.1 4700.3 4701.2 4705.7 4747.6 4558.7 4681.3 4739.4 4753.0 4760.7 4966.2 4983.2 4997.2 5007.8 5032.7 5468.5 5477.6 5480.9 5485.4 5525.7 5441.4 5492.5 5495.6 5496.0 5534.0 5184.1 5189.0 5199.2 5206.5 5206.5 5626.0 5630.2 5645.9 5646.2 5650.9 5301.3 5393.2 5426.5 5427.0 5485.6 5450.1 5486.1 5507.3 5511.3 5540.0 5379.9 5495.6 5498.8 5502.9 5568.8 5466.2 5492.3 5506.0 5515.4 5523.2 4312.4 4315.1 4329.8 4331.1 4359.4 3781.1 3889.4 3897.8 3901.0 3935.8 5016.1 5040.9 5060.1 5060.4 5091.4 5349.5 5491.9 5500.7 5506.6 5542.8 5022.9 5073.5 5076.4 5099.6 5126.4 4743.7 4802.6 4804.9 4816.3 4847.0 5604.8 5737.1 5795.0 5800.3 5831.4 5553.9 5577.4 5577.8 5578.4 5595.0 5778.7 5787.8 5788.1 5789.7 5794.4 5302.6 5437.5 5474.8 5516.3 5520.5 5527.7 5537.9 5540.1 5554.4 5559.6 5260.8 5399.1 5419.0 5427.1 5484.0 5366.1 5380.8 5399.1 5412.0 5455.8 5202.4 5235.8 5244.3 5245.7 5284.3 5297.1 5372.9 5376.5 5400.1 5454.8 5115.2 5176.6 5194.4 5200.1 5250.5 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | [#1] ext.html Cycles:180 Average:44933.12 Median:33709.33 stddev:74021.86 (219.6%) stddev-sans-first:74154.38 05:19:55 INFO - PROCESS | 11306 | Values: 514.2 518.0 533.1 542.5 586.5 28189.7 39587.8 39804.2 39806.4 39880.0 43796.6 44321.8 44332.3 44461.3 44464.3 8660.2 8871.7 8875.6 8876.8 8877.9 8709.1 8854.2 8878.1 8884.8 8885.2 8817.4 8886.8 8904.0 8905.1 8906.4 8760.6 8832.5 8844.6 8847.5 8853.5 8755.6 8870.6 8891.1 8892.4 8892.4 40446.6 40822.6 40879.8 40886.0 40944.8 3211.0 3249.6 3307.7 3421.6 3927.8 30094.4 30643.0 31469.2 31745.4 32073.0 3684.8 3732.6 3808.5 3824.1 3961.6 278847.0 279971.0 280489.0 280968.0 282346.0 57631.7 58708.7 58715.7 58799.0 58854.0 61455.7 61532.0 61637.0 61736.0 61744.0 16320.8 16700.7 16756.6 16769.8 16779.2 12502.0 12584.7 12614.9 12641.2 12671.6 18845.0 19551.3 19771.5 19848.0 19943.3 7406.6 7556.8 7633.5 7639.0 7754.4 941.7 984.5 1011.2 1034.6 1040.0 28573.9 29253.7 29567.9 29735.0 29812.7 902.5 1045.5 1051.8 1058.2 1060.5 13636.3 13701.5 13741.2 15797.2 15957.6 330180.0 330372.0 336020.0 336168.0 336574.8 45802.0 52787.0 53560.0 53598.7 53606.0 1367.0 1384.6 1399.5 1400.7 1401.4 26125.7 28064.4 28291.6 28799.9 28983.4 42805.6 42996.6 43421.0 43448.0 43528.1 204738.0 206191.5 206492.0 206590.0 284356.0 31373.5 31772.7 31774.2 31775.8 31803.2 37154.0 37721.6 37984.1 38140.8 38407.4 32462.8 32906.3 33274.3 33511.8 33737.0 32472.0 35263.6 36062.5 36223.0 36858.3 33065.0 33351.3 33537.5 33647.0 33681.7 30021.8 31448.4 32776.3 32844.3 32960.7 24565.9 24909.9 25003.0 25322.7 25352.7 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | [#2] jquery.html Cycles:180 Average:24123.35 Median:376.43 stddev:60240.82 (16003.3%) stddev-sans-first:60383.41 05:19:55 INFO - PROCESS | 11306 | Values: 368.5 368.7 372.5 374.3 378.6 13840.1 16494.0 17104.6 17599.1 17871.5 16784.6 16793.8 17131.4 17764.0 17870.3 5511.8 5572.9 5609.0 5675.9 5681.2 4000.6 5419.3 5926.7 6140.1 6153.6 6086.8 6091.8 6092.8 6116.8 6129.2 5905.6 6058.2 6122.4 6123.8 6124.4 5446.4 5461.8 5463.4 5465.8 5468.4 20503.3 21040.7 21209.2 21479.9 21520.6 2116.9 2355.3 2391.5 2417.9 2473.6 13247.0 13282.7 13291.1 13370.9 13812.0 1833.8 1837.3 1888.2 1956.1 2069.3 71273.0 71631.9 74245.3 74808.6 75507.6 15197.2 15689.3 15844.6 15846.4 15873.6 24414.3 24635.0 24723.0 24840.6 24858.8 9147.2 9317.4 9378.6 9442.6 9521.3 8142.8 8187.5 8205.0 8211.7 8260.2 7822.4 7881.3 7896.2 7932.0 7970.6 2562.9 2950.5 3019.8 3057.6 3085.9 797.9 918.6 934.5 992.3 1015.4 16128.6 16956.0 16979.6 17258.4 17466.9 394.5 443.2 446.8 457.4 887.0 5156.6 5593.7 5610.5 5754.8 5809.9 325741.0 331264.0 332013.0 395900.0 427796.0 59967.7 63382.7 72422.6 75407.0 78869.2 474.1 480.0 481.5 482.2 483.9 9848.3 10420.4 10452.6 10753.5 10794.4 33128.7 35054.3 35167.5 35845.3 36318.0 49336.3 49388.5 49561.0 49641.5 49697.0 7776.0 7801.1 7803.4 7929.6 8021.8 12293.6 12618.4 12657.6 12672.2 12969.9 10344.5 10646.5 10747.6 10874.2 10934.9 10840.2 11083.3 11151.2 11203.4 11266.6 11319.3 11494.3 11529.1 11897.6 11908.3 6668.6 7723.2 7737.5 7910.4 7931.1 8869.8 11052.7 11106.9 11107.9 11292.0 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | [#3] mootools.html Cycles:180 Average:5571.37 Median:6368.76 stddev:2956.88 (46.4%) stddev-sans-first:2947.12 05:19:55 INFO - PROCESS | 11306 | Values: 1225.2 1467.0 1484.6 1651.7 1798.7 7685.6 7877.1 7906.5 7924.3 7937.8 7723.0 7840.2 7919.6 7939.9 7945.9 1969.2 2279.2 2281.3 2312.1 2334.4 2270.7 2273.2 2278.2 2279.3 2280.8 2277.9 2278.4 2280.2 2281.8 2286.1 2215.1 2243.3 2262.6 2263.5 2265.3 2255.5 2258.2 2274.2 2312.2 2313.0 8003.6 8043.5 8055.6 8059.5 8083.4 4676.2 4801.6 4801.6 4808.0 4808.5 3141.2 3158.7 3159.8 3236.2 3267.7 1063.8 1071.1 1078.7 1083.2 1095.2 11202.0 11322.5 11343.4 11349.9 11366.1 4298.8 4305.6 4345.9 4355.5 4358.1 9594.1 9596.4 9601.8 9605.3 9623.9 4173.7 4634.9 4844.7 4848.4 4852.6 4171.8 4255.3 4265.3 4283.2 4293.0 3655.9 3675.9 3690.6 3707.0 3729.3 1121.8 1132.8 1136.8 1155.0 1167.8 1316.3 1320.0 1339.6 1340.3 1341.1 7566.8 7682.5 7683.6 7685.5 7692.0 457.8 464.7 464.8 465.4 478.9 5623.3 5628.5 5630.8 5660.2 5660.4 9364.6 9389.6 9505.1 9546.9 9585.8 9309.5 9333.2 9426.5 9429.6 9475.1 7355.5 7414.7 7455.7 7463.6 7516.4 7439.2 7461.7 7502.5 7523.8 7543.7 8351.6 8482.9 8688.6 8697.3 8706.4 8681.7 8865.1 8865.2 8885.2 8895.6 6148.8 6840.8 7017.0 7053.3 7121.9 7721.0 7726.6 7729.0 7806.7 7815.8 6821.6 7067.6 7133.1 7139.0 7256.0 7063.4 7072.2 7141.2 7184.7 7196.6 7251.1 7267.7 7272.9 7273.8 7289.4 6588.8 6592.3 6607.3 6616.5 6621.9 6832.3 6842.5 6846.9 6847.0 6861.4 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | [#4] prototype.html Cycles:180 Average:5171.87 Median:5811.24 stddev:1549.50 (26.7%) stddev-sans-first:1510.60 05:19:55 INFO - PROCESS | 11306 | Values: 328.1 328.7 330.4 343.7 344.9 5805.5 5813.6 5833.4 5841.7 5867.5 5531.0 5648.5 5747.0 5818.3 5836.9 4496.5 4496.9 4509.3 4510.9 4514.5 4349.8 4505.5 4512.9 4518.8 4520.2 4399.6 4488.4 4506.9 4522.8 4533.8 4512.7 4513.5 4513.8 4517.4 4530.3 4010.5 4011.7 4014.5 4020.5 4024.3 5584.7 5590.4 5597.0 5597.0 5606.5 5237.5 5244.5 5249.1 5250.6 5269.2 5974.7 6155.7 6159.0 6163.3 6170.3 4244.3 4251.8 4253.6 4267.4 4267.9 6382.2 6457.7 6465.0 6471.0 6475.6 4402.4 4403.4 4405.0 4405.4 4407.2 4446.7 4456.3 4458.7 4459.4 4463.3 5080.5 5144.7 5159.6 5197.1 5198.4 6139.8 6203.8 6216.5 6244.4 6249.1 1482.2 1516.8 1531.3 1567.2 1569.1 1011.1 1020.5 1032.5 1047.2 1059.3 5773.3 5787.2 5832.1 5832.8 5839.6 6334.6 6351.3 6401.3 6424.8 6439.5 5790.1 5792.0 5793.3 5794.4 5808.9 3375.4 3379.2 3381.4 3381.5 3381.6 6243.6 6381.3 6400.8 6411.1 6510.7 6331.8 6332.2 6383.1 6390.1 6395.2 6472.0 6477.7 6477.9 6481.8 6481.9 6196.6 6203.2 6203.6 6208.4 6215.0 6126.7 6200.1 6200.5 6205.2 6218.8 6542.9 6799.0 6804.9 6805.6 6808.0 4398.3 4454.2 4456.6 4461.4 4473.6 6254.9 6322.1 6492.1 6501.6 6502.0 6291.7 6299.7 6313.1 6319.9 6320.4 6297.0 6300.0 6300.1 6305.6 6308.5 6129.7 6144.4 6145.9 6147.0 6150.3 6153.4 6293.3 6312.5 6327.6 6333.7 6097.1 6139.6 6171.1 6177.4 6197.0 05:19:55 INFO - PROCESS | 11306 | 05:19:55 INFO - PROCESS | 11306 | [#5] yui.html Cycles:180 Average:14224.22 Median:25382.50 stddev:16442.93 (64.8%) stddev-sans-first:16457.87 05:19:55 INFO - PROCESS | 11306 | Values: 738.9 739.9 752.7 820.4 830.8 13400.7 13722.9 13801.8 13881.9 13897.7 11762.8 13803.4 14174.8 14277.4 14383.6 672.4 680.1 681.5 826.9 834.0 678.0 818.9 834.7 835.8 837.0 869.1 869.9 870.4 870.5 873.8 711.5 845.6 856.4 864.2 871.7 630.4 631.2 633.1 633.6 634.1 14068.9 14115.8 14155.6 14175.6 14177.3 13313.9 13538.2 13839.7 13963.9 13996.9 10470.9 10482.3 10827.5 10922.0 10982.1 3620.3 3655.3 3666.2 3788.3 3789.1 49597.3 51004.2 52858.5 53400.5 53424.5 10615.8 10793.4 10821.8 11083.3 11120.6 18751.7 18774.4 18775.1 18787.2 18815.5 7833.6 8050.0 8105.3 8113.9 8120.9 4451.4 4581.6 4614.2 4638.7 4643.2 3229.5 3257.3 3259.3 3270.4 3281.4 592.1 592.1 593.4 595.7 607.9 649.0 654.4 661.6 662.8 665.9 8633.5 8943.6 8986.7 9006.5 9182.1 613.8 615.2 618.7 626.2 629.9 3672.1 3822.8 3832.5 4005.8 4010.7 56102.4 57538.7 57901.0 57906.0 58004.7 49626.5 50012.5 50104.7 51846.7 51984.7 45148.3 45498.3 47994.5 48257.3 49320.5 8401.6 8569.0 8654.4 8706.0 8829.6 37038.0 37847.2 38488.8 40653.0 40906.4 45172.3 45832.8 45896.0 46150.8 48699.0 11232.3 11275.7 11326.0 11504.4 11648.6 11090.1 11242.8 11329.6 11347.9 12131.0 11078.5 11279.2 11280.6 11615.7 11903.5 10658.3 10734.7 10771.6 11026.9 11181.8 10959.7 11183.1 11372.1 11613.2 11750.5 9736.0 9849.8 9958.3 10037.6 10046.2 9141.6 9145.2 9375.2 9977.1 10008.6 05:19:55 INFO - PROCESS | 11306 | -------- Summary: end -------- 05:19:55 INFO - PROCESS | 11306 | 05:19:56 INFO - TEST-INFO | 11306: exit 0 05:19:56 INFO - TEST-OK | dromaeo_css | took 1114674ms 05:19:56 INFO - TEST-START | kraken 05:19:56 INFO - operating with platform_type : linux_ 05:19:56 INFO - Initialising browser for kraken test... 05:19:56 INFO - TEST-INFO | started process 11497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5dKEQU/profile http://localhost:55150/getInfo.html) 05:20:01 INFO - PROCESS | 11497 | __metrics Screen width/height:1600/1200 05:20:01 INFO - PROCESS | 11497 | colorDepth:24 05:20:01 INFO - PROCESS | 11497 | Browser inner width/height: 1024/697 05:20:01 INFO - PROCESS | 11497 | __metrics 05:20:02 INFO - PROCESS | 11497 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:03 INFO - TEST-INFO | 11497: exit 0 05:20:03 INFO - Browser initialized. 05:20:03 INFO - Running cycle 1/1 for kraken test... 05:20:03 INFO - TEST-INFO | started process 11581 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5dKEQU/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:15 INFO - PROCESS | 11581 | RSS: Main: 147456000 05:20:15 INFO - PROCESS | 11581 | 05:20:17 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55150/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:18 INFO - PROCESS | 11581 | RSS: Main: 193609728 05:20:18 INFO - PROCESS | 11581 | 05:20:21 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55150/tests/kraken/driver.html?testName=audio-dft) 05:20:21 INFO - PROCESS | 11581 | RSS: Main: 182779904 05:20:21 INFO - PROCESS | 11581 | 05:20:24 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55150/tests/kraken/driver.html?testName=audio-fft) 05:20:25 INFO - PROCESS | 11581 | RSS: Main: 166277120 05:20:25 INFO - PROCESS | 11581 | 05:20:27 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55150/tests/kraken/driver.html?testName=audio-oscillator) 05:20:27 INFO - PROCESS | 11581 | RSS: Main: 168333312 05:20:27 INFO - PROCESS | 11581 | 05:20:30 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55150/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:30 INFO - PROCESS | 11581 | RSS: Main: 169930752 05:20:30 INFO - PROCESS | 11581 | 05:20:33 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55150/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:34 INFO - PROCESS | 11581 | RSS: Main: 170434560 05:20:34 INFO - PROCESS | 11581 | 05:20:37 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55150/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:38 INFO - PROCESS | 11581 | RSS: Main: 171241472 05:20:38 INFO - PROCESS | 11581 | 05:20:40 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55150/tests/kraken/driver.html?testName=json-parse-financial) 05:20:41 INFO - PROCESS | 11581 | RSS: Main: 171503616 05:20:41 INFO - PROCESS | 11581 | 05:20:43 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55150/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:43 INFO - PROCESS | 11581 | RSS: Main: 181780480 05:20:43 INFO - PROCESS | 11581 | 05:20:45 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:46 INFO - PROCESS | 11581 | RSS: Main: 180023296 05:20:46 INFO - PROCESS | 11581 | 05:20:48 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:48 INFO - PROCESS | 11581 | RSS: Main: 192806912 05:20:48 INFO - PROCESS | 11581 | 05:20:51 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:51 INFO - PROCESS | 11581 | RSS: Main: 197926912 05:20:51 INFO - PROCESS | 11581 | 05:20:54 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:54 INFO - PROCESS | 11581 | RSS: Main: 196861952 05:20:54 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | Cycle 1(1): loaded http://localhost:55150/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55150/tests/kraken/driver.html?testName=ai-astar) 05:20:56 INFO - PROCESS | 11581 | RSS: Main: 256061440 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | __start_tp_report 05:20:56 INFO - PROCESS | 11581 | _x_x_mozilla_page_load 05:20:56 INFO - PROCESS | 11581 | _x_x_mozilla_page_load_details 05:20:56 INFO - PROCESS | 11581 | |i|pagename|runs| 05:20:56 INFO - PROCESS | 11581 | |0;ai-astar;112;112;109;110;112;112;100;112;110;112 05:20:56 INFO - PROCESS | 11581 | |1;audio-beat-detection;150;126;155;174;133;156;163;131;181;125 05:20:56 INFO - PROCESS | 11581 | |2;audio-dft;159;161;161;159;160;161;161;163;161;160 05:20:56 INFO - PROCESS | 11581 | |3;audio-fft;73;74;102;95;75;75;73;125;95;73 05:20:56 INFO - PROCESS | 11581 | |4;audio-oscillator;96;96;143;97;96;98;144;96;97;138 05:20:56 INFO - PROCESS | 11581 | |5;imaging-gaussian-blur;120;116;115;116;115;114;115;115;116;115 05:20:56 INFO - PROCESS | 11581 | |6;imaging-darkroom;147;147;145;146;146;145;145;145;146;145 05:20:56 INFO - PROCESS | 11581 | |7;imaging-desaturate;96;97;95;96;96;95;97;95;96;95 05:20:56 INFO - PROCESS | 11581 | |8;json-parse-financial;60;57;56;56;56;56;58;66;54;54 05:20:56 INFO - PROCESS | 11581 | |9;json-stringify-tinderbox;67;66;67;68;68;67;67;67;67;67 05:20:56 INFO - PROCESS | 11581 | |10;stanford-crypto-aes;82;81;82;82;83;83;81;82;82;81 05:20:56 INFO - PROCESS | 11581 | |11;stanford-crypto-ccm;121;115;116;113;122;114;115;120;128;115 05:20:56 INFO - PROCESS | 11581 | |12;stanford-crypto-pbkdf2;150;138;149;150;150;146;150;150;161;150 05:20:56 INFO - PROCESS | 11581 | |13;stanford-crypto-sha256-iterative;70;68;70;69;68;67;68;69;67;68 05:20:56 INFO - PROCESS | 11581 | __end_tp_report 05:20:56 INFO - PROCESS | 11581 | __start_cc_report 05:20:56 INFO - PROCESS | 11581 | _x_x_mozilla_cycle_collect,947 05:20:56 INFO - PROCESS | 11581 | __end_cc_report 05:20:56 INFO - PROCESS | 11581 | __startTimestamp1456147256777__endTimestamp 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | ------- Summary: start ------- 05:20:56 INFO - PROCESS | 11581 | Number of tests: 14 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.73 (3.3%) stddev-sans-first:3.89 05:20:56 INFO - PROCESS | 11581 | Values: 112.0 112.0 109.0 110.0 112.0 112.0 100.0 112.0 110.0 112.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#1] audio-beat-detection Cycles:10 Average:149.40 Median:155.50 stddev:20.04 (12.9%) stddev-sans-first:21.25 05:20:56 INFO - PROCESS | 11581 | Values: 150.0 126.0 155.0 174.0 133.0 156.0 163.0 131.0 181.0 125.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.17 (0.7%) stddev-sans-first:1.09 05:20:56 INFO - PROCESS | 11581 | Values: 159.0 161.0 161.0 159.0 160.0 161.0 161.0 163.0 161.0 160.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#3] audio-fft Cycles:10 Average:86.00 Median:74.50 stddev:17.74 (23.8%) stddev-sans-first:18.18 05:20:56 INFO - PROCESS | 11581 | Values: 73.0 74.0 102.0 95.0 75.0 75.0 73.0 125.0 95.0 73.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:21.85 (22.8%) stddev-sans-first:22.57 05:20:56 INFO - PROCESS | 11581 | Values: 96.0 96.0 143.0 97.0 96.0 98.0 144.0 96.0 97.0 138.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.50 stddev:1.64 (1.4%) stddev-sans-first:0.67 05:20:56 INFO - PROCESS | 11581 | Values: 120.0 116.0 115.0 116.0 115.0 114.0 115.0 115.0 116.0 115.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 05:20:56 INFO - PROCESS | 11581 | Values: 147.0 147.0 145.0 146.0 146.0 145.0 145.0 145.0 146.0 145.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 05:20:56 INFO - PROCESS | 11581 | Values: 96.0 97.0 95.0 96.0 96.0 95.0 97.0 95.0 96.0 95.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:56.50 stddev:3.53 (6.2%) stddev-sans-first:3.61 05:20:56 INFO - PROCESS | 11581 | Values: 60.0 57.0 56.0 56.0 56.0 56.0 58.0 66.0 54.0 54.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 05:20:56 INFO - PROCESS | 11581 | Values: 67.0 66.0 67.0 68.0 68.0 67.0 67.0 67.0 67.0 67.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 05:20:56 INFO - PROCESS | 11581 | Values: 82.0 81.0 82.0 82.0 83.0 83.0 81.0 82.0 82.0 81.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.00 stddev:4.72 (4.0%) stddev-sans-first:4.88 05:20:56 INFO - PROCESS | 11581 | Values: 121.0 115.0 116.0 113.0 122.0 114.0 115.0 120.0 128.0 115.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:150.00 stddev:5.56 (3.7%) stddev-sans-first:5.89 05:20:56 INFO - PROCESS | 11581 | Values: 150.0 138.0 149.0 150.0 150.0 146.0 150.0 150.0 161.0 150.0 05:20:56 INFO - PROCESS | 11581 | 05:20:56 INFO - PROCESS | 11581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:0.97 05:20:56 INFO - PROCESS | 11581 | Values: 70.0 68.0 70.0 69.0 68.0 67.0 68.0 69.0 67.0 68.0 05:20:56 INFO - PROCESS | 11581 | -------- Summary: end -------- 05:20:56 INFO - PROCESS | 11581 | 05:20:57 INFO - TEST-INFO | 11581: exit 0 05:20:57 INFO - TEST-OK | kraken | took 61028ms 05:20:57 INFO - SUITE-END | took 1175s 05:20:57 INFO - Completed test suite (00:19:35) 05:20:57 INFO - Working with test: dromaeo_css 05:20:57 INFO - Generating results file: dromaeo_css 05:20:57 INFO - Working with test: kraken 05:20:57 INFO - Generating results file: kraken 05:20:57 INFO - javascript benchmark 05:20:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:20:57 INFO - process_Request line: dromaeo_css 6899.97 graph.html#tests=[[72,64,35]] 05:20:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:20:58 INFO - process_Request line: kraken 1515.40 graph.html#tests=[[232,64,35]] 05:20:58 INFO - RETURN: dromaeo_css: 6899.97 05:20:58 INFO - RETURN: kraken: 1515.40 05:20:58 INFO - javascript benchmark 05:20:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3128.327409606935, 3147.6537580866116, 3191.6967888050626, 3199.0, 3223.8710451581937, 4978.45237023928, 5022.623303252252, 5111.207762796763, 5154.742262886854, 5158.200478925773, 5122.795088196477, 5131.589472842173, 5203.271541984125, 5235.79056837727, 5278.102722537168, 4595.609373203281, 4689.320048592952, 4694.319323698071, 4739.289106634015, 4860.951390486085, 4789.0, 4789.832355867546, 4815.879603009917, 4842.636802239828, 4863.68386054907, 4559.954400456003, 4649.67452278339, 4723.031778485402, 4775.355327030841, 4776.617870570381, 4665.09030739006, 4700.271457924027, 4701.177293973575, 4705.670603057787, 4747.643926705511, 4558.749268790215, 4681.297805329194, 4739.3838800956, 4753.0, 4760.714357138548, 4966.230234313651, 4983.227599722049, 4997.150484417622, 5007.799688012475, 5032.6980381177245, 5468.535174510172, 5477.589180811416, 5480.862978425571, 5485.396606373296, 5525.723713814293, 5441.428649991733, 5492.505674489315, 5495.6153069285165, 5496.0, 5534.0, 5184.11869982104, 5189.0, 5199.2461093141665, 5206.505381988705, 5206.531412172884, 5625.971870140623, 5630.23991761107, 5645.887082258414, 5646.181303710939, 5650.858728531737, 5301.310829592128, 5393.191021346829, 5426.511613954763, 5426.972865135728, 5485.588580856372, 5450.127979523258, 5486.067368547357, 5507.256520369779, 5511.255980442669, 5539.972300138554, 5379.892402151935, 5495.642783219078, 5498.780048798083, 5502.944970550243, 5568.832935011957, 5466.152746324246, 5492.286002819608, 5505.9724701376235, 5515.365732940683, 5523.171524271392, 4312.417823593837, 4315.050688848449, 4329.848455304113, 4331.068820203672, 4359.411479450297, 3781.0736369589076, 3889.4360317753767, 3897.7661340319673, 3900.9804950975063, 3935.7835319057153, 5016.122178618727, 5040.924386134211, 5060.089183946925, 5060.3927528696795, 5091.363579552556, 5349.518543331119, 5491.890162196733, 5500.697461639648, 5506.587005974568, 5542.75057622408, 5022.874428139326, 5073.467285934998, 5076.3908330999775, 5099.617528685363, 5126.359205099363, 4743.691660042086, 4802.639802014793, 4804.927926081042, 4816.349792778, 4847.030593881238, 5604.8318550443555, 5737.053386191315, 5795.0, 5800.332961709373, 5831.416858314219, 5553.861153471195, 5577.358603760619, 5577.8047768327915, 5578.414266501959, 5595.0, 5778.653280803165, 5787.797427090031, 5788.13178023283, 5789.652620842763, 5794.3626201117, 5302.602304827231, 5437.510624043855, 5474.753636086465, 5516.310461192351, 5520.503154716095, 5527.695976721319, 5537.944620553743, 5540.058190107772, 5554.389017208023, 5559.610827242054, 5260.815871444481, 5399.05516534597, 5418.972905135449, 5427.104527753035, 5484.040292948798, 5366.060939335679, 5380.838574842761, 5399.055165346127, 5412.0, 5455.754491047833, 5202.375714914235, 5235.816746413857, 5244.265802787689, 5245.659032162897, 5284.26020357158, 5297.099493086262, 5372.925414916954, 5376.516113549799, 5400.135978243462, 5454.8090816822805, 5115.232715092617, 5176.611754118381, 5194.402643696023, 5200.063988482109, 5250.501202385767], "unit": "score", "name": "dojo.html", "value": 5092.6321713768575}, {"lowerIsBetter": false, "replicates": [514.1773162939297, 517.9976744998428, 533.1203514201568, 542.476510167688, 586.5014737473145, 28189.71810281899, 39587.80206098973, 39804.203915921666, 39806.40290395643, 39880.0, 43796.56203437965, 44321.77839110808, 44332.33501497472, 44461.333080003824, 44464.3330350045, 8660.177283158106, 8871.733847984571, 8875.556222188898, 8876.778080547974, 8877.911220887805, 8709.129087091273, 8854.247388971946, 8878.067802880701, 8884.822303553925, 8885.155910188554, 8817.382783205177, 8886.777830554256, 8904.0, 8905.064968178345, 8906.376553641248, 8760.561971901412, 8832.514211718353, 8844.646214151426, 8847.46915185091, 8853.468791872509, 8755.649774009033, 8870.645174193025, 8891.110888911122, 8892.377533572653, 8892.421992570462, 40446.59553404458, 40822.591774082175, 40879.795601021804, 40886.0, 40944.795276023724, 3211.0366889932925, 3249.6425393206728, 3307.6526964668606, 3421.606515250753, 3927.8428862845453, 30094.398112037856, 30643.0, 31469.213269668213, 31745.365092698015, 32073.0, 3684.8157592120288, 3732.64539868712, 3808.4668146459517, 3824.139568597071, 3961.623645753649, 278847.0, 279971.0, 280489.0, 280968.0, 282346.0, 57631.71184144053, 58708.706456467444, 58715.70642146847, 58799.0, 58854.0, 61455.692721537, 61532.0, 61637.0, 61736.0, 61744.0, 16320.75518867218, 16700.74948875768, 16756.581085472717, 16769.81992340988, 16779.161041947853, 12502.0, 12584.685382865502, 12614.873851261553, 12641.178323408949, 12671.556495522796, 18844.969733626196, 19551.315703950295, 19771.505712357306, 19848.0, 19943.301984430476, 7406.555606663617, 7556.773296801105, 7633.465657404039, 7638.961805191049, 7754.3796496280165, 941.6562954521687, 984.4683870709737, 1011.2466212671607, 1034.6482196053378, 1039.9740006499899, 28573.857130714212, 29253.707462925526, 29567.852160739058, 29735.0, 29812.701872980993, 902.4675441489553, 1045.4668119259081, 1051.8054159980275, 1058.169337070396, 1060.4962642744636, 13636.318184090955, 13701.520446784314, 13741.24423156716, 15797.21013949298, 15957.601059973593, 330180.0, 330372.0, 336020.0, 336168.0, 336574.80551167007, 45802.0, 52787.0, 53560.0, 53598.73200633972, 53606.0, 1366.9863301366859, 1384.605387464588, 1399.4542128569865, 1400.6848459096418, 1401.3763875075697, 26125.73874261309, 28064.43871122607, 28291.575626366033, 28799.85600071986, 28983.420331593672, 42805.57194428016, 42996.57003429926, 43421.0, 43448.0, 43528.12943741044, 204738.0, 206191.50467962227, 206492.0, 206590.0, 284356.0, 31373.52939705952, 31772.710684057358, 31774.205644859063, 31775.841120795172, 31803.20491987719, 37154.0, 37721.62278377181, 37984.050398740255, 38140.80929595445, 38407.42388864225, 32462.83768581142, 32906.341873162884, 33274.33451331008, 33511.83244083764, 33737.0, 32472.0, 35263.64736352706, 36062.45906311355, 36223.0, 36858.26283474369, 33065.0, 33351.332973339915, 33537.49693754644, 33647.0, 33681.66318336883, 30021.849890750407, 31448.37103257876, 32776.34447311088, 32844.34311313808, 32960.67039329576, 24565.93613272354, 24909.875450622632, 25003.0, 25322.74677253204, 25352.732363381387], "unit": "score", "name": "ext.html", "value": 18288.69805029945}, {"lowerIsBetter": false, "replicates": [368.50252159584545, 368.7031939288873, 372.49154903556644, 374.25896724485517, 378.5949034533047, 13840.100393474442, 16494.01035937843, 17104.57238569035, 17599.1200439978, 17871.463856084305, 16784.580385490368, 16793.83206167938, 17131.400400985967, 17764.0, 17870.28518859244, 5511.751971161298, 5572.888542229153, 5609.0, 5675.886482270373, 5681.176229446728, 4000.599940006005, 5419.268398766175, 5926.703664816763, 6140.140380346755, 6153.630782153063, 6086.7565297388055, 6091.78678746244, 6092.756289748427, 6116.8470788230425, 6129.172561704179, 5905.557083218754, 6058.182145410379, 6122.387761223887, 6123.785667501638, 6124.418180272867, 5446.400895901447, 5461.754221060062, 5463.371712253102, 5465.781368745245, 5468.425815289377, 20503.2823851166, 21040.737555746706, 21209.151633934624, 21479.892600536896, 21520.56958860814, 2116.9047392867205, 2355.3051849704207, 2391.545606334791, 2417.8791060447084, 2473.6042233242597, 13247.0, 13282.667933301647, 13291.069625126245, 13370.866291337059, 13812.0, 1833.7891142518647, 1837.3477415517566, 1888.1597689028388, 1956.1099699636632, 2069.265410779182, 71273.0, 71631.92552111775, 74245.25754742492, 74808.62595687041, 75507.62246188789, 15197.164155971306, 15689.293981770848, 15844.603884902739, 15846.445374412071, 15873.603159920864, 24414.26757197287, 24635.0, 24723.0, 24840.627390589154, 24858.751412485643, 9147.176754092163, 9317.44095354281, 9378.624855005859, 9442.57508412123, 9521.28590355726, 8142.796430089295, 8187.5087494750505, 8205.0, 8211.671533138608, 8260.173982601691, 7822.374210063182, 7881.330086942559, 7896.249856263646, 7931.968844050237, 7970.561619110888, 2562.9102981395563, 2950.4836653585535, 3019.805933793871, 3057.556654285116, 3085.876564937377, 797.8962734844549, 918.6463211663557, 934.509382574154, 992.2558081438921, 1015.4009134610615, 16128.596785080466, 16956.0, 16979.575510612085, 17258.395956141474, 17466.912665436845, 394.48125714685096, 443.1579998003754, 446.76991349455056, 457.38024976157493, 886.9911300887038, 5156.5561642740095, 5593.692346920959, 5610.5231055360755, 5754.798582049608, 5809.8547536311935, 325741.0, 331264.0, 332013.0, 395900.0, 427796.0, 59967.679892133914, 63382.68308658427, 72422.63788681023, 75407.0, 78869.21130788734, 474.11814025911775, 480.0255481372749, 481.458359345736, 482.1538200458173, 483.8620993016973, 9848.310618256653, 10420.374777513374, 10452.581896724047, 10753.46232688378, 10794.352338859693, 33128.66871331256, 35054.29891402209, 35167.47248791219, 35845.28309433849, 36318.0, 49336.25995610141, 49388.50611493839, 49561.0, 49641.50358496369, 49697.0, 7775.961120194363, 7801.141874393698, 7803.414743894117, 7929.563873986986, 8021.839563208587, 12293.56972505958, 12618.36908154607, 12657.556985505464, 12672.176308539916, 12969.935150324189, 10344.53449594755, 10646.467676615983, 10747.623833165802, 10874.184436167161, 10934.90650934932, 10840.241183117107, 11083.33499989971, 11151.16366272549, 11203.439828008404, 11266.605668801552, 11319.320840749582, 11494.310341379543, 11529.135314851588, 11897.643070707893, 11908.285502869856, 6668.566543174678, 7723.227677232232, 7737.458377913492, 7910.367170626451, 7931.051562732318, 8869.822603548022, 11052.668419947415, 11106.944465277622, 11107.888921111009, 11292.0], "unit": "score", "name": "jquery.html", "value": 8631.934943774202}, {"lowerIsBetter": false, "replicates": [1225.2219840401353, 1467.0464198271125, 1484.5843163914105, 1651.7274649682804, 1798.685230084735, 7685.615719214038, 7877.133515313318, 7906.525608463489, 7924.286814186722, 7937.761867143995, 7722.961385193066, 7840.176781437938, 7919.56442395668, 7939.92060079399, 7945.92054079459, 1969.2123150739676, 2279.1567120165564, 2281.338411860567, 2312.09828167015, 2334.4163959010248, 2270.738865030518, 2273.1702928431087, 2278.214016164429, 2279.2706333973133, 2280.8289378296613, 2277.8974946127382, 2278.396225000376, 2280.2133264023887, 2281.7718228177214, 2286.0969916882823, 2215.102883332253, 2243.2821497120926, 2262.592733308004, 2263.4907145892207, 2265.3430505153488, 2255.5263394687136, 2258.153192552793, 2274.1926616051396, 2312.2485192312565, 2312.9653055204185, 8003.599820008976, 8043.517388956681, 8055.5972201389695, 8059.516429014219, 8083.353331733506, 4676.205045142334, 4801.615870730333, 4801.639877009238, 4808.038392321515, 4808.495108013678, 3141.2461009357817, 3158.699923507263, 3159.8262095584732, 3236.158598764315, 3267.738580913521, 1063.8351055586397, 1071.1484369925927, 1078.654830454255, 1083.214669364712, 1095.1622009162998, 11201.999999999918, 11322.490487928064, 11343.376114313709, 11349.886501134966, 11366.147538934612, 4298.806553705091, 4305.590968857953, 4345.869623911288, 4355.455568053993, 4358.084802191512, 9594.1365277124, 9596.376235544667, 9601.759956001157, 9605.327627066177, 9623.903760962441, 4173.6661067114555, 4634.86095417138, 4844.685095468783, 4848.393950756155, 4852.636052296021, 4171.791410429466, 4255.255330317244, 4265.317549192115, 4283.2290187765875, 4292.957070429318, 3655.926881462356, 3675.852965881388, 3690.5755838078426, 3707.0361705956648, 3729.254149170177, 1121.8429419881222, 1132.7960967026015, 1136.778328225988, 1154.9836144193057, 1167.8481797366287, 1316.3023597493343, 1319.9868001319865, 1339.5512503311304, 1340.2896464873634, 1341.0545565376385, 7566.772996810105, 7682.539047657158, 7683.615819209017, 7685.4620176587105, 7692.0, 457.8420444946488, 464.7443905851768, 464.7885212228428, 465.40428251837704, 478.89943111946883, 5623.325200975827, 5628.521575666033, 5630.831075067673, 5660.20757093999, 5660.377358490563, 9364.578593963288, 9389.577469013911, 9505.097015783489, 9546.90453095474, 9585.760355991017, 9309.487978161265, 9333.160015598629, 9426.528673566294, 9429.575669094907, 9475.147236748726, 7355.521891077063, 7414.666340014604, 7455.739049133254, 7463.552186868806, 7516.436267279976, 7439.181690013986, 7461.664225109775, 7502.549847009197, 7523.774286771406, 7543.660535275816, 8351.582420879053, 8482.872756908528, 8688.609012594323, 8697.260732837527, 8706.434081784664, 8681.696140635047, 8865.069167737553, 8865.157810008039, 8885.155910188521, 8895.555222238992, 6148.754049837957, 6840.794776156524, 7016.964915175391, 7053.259407762316, 7121.893171602326, 7721.03487064117, 7726.575038372944, 7728.961355193188, 7806.687732490636, 7815.765527034198, 6821.590704557742, 7067.646617669199, 7133.072700548895, 7138.964305178441, 7256.0, 7063.36429721307, 7072.222055573986, 7141.178764442156, 7184.676689548878, 7196.640167991684, 7251.057362543047, 7267.709291628275, 7272.89090663651, 7273.781786546412, 7289.380402665833, 6588.769393071411, 6592.340765923561, 6607.273199947906, 6616.470682345497, 6621.9337806621315, 6832.282610326043, 6842.521023528305, 6846.931530684828, 6847.0, 6861.416779573792], "unit": "score", "name": "mootools.html", "value": 4472.6744244100355}, {"lowerIsBetter": false, "replicates": [328.07973633956755, 328.73865277104716, 330.42670965874214, 343.71986830732965, 344.8844637046589, 5805.506531944785, 5813.622114562556, 5833.3874943130995, 5841.678707671076, 5867.4719275265215, 5531.004419204542, 5648.4633959773855, 5747.0, 5818.330891947417, 5836.9124463133085, 4496.4829044659955, 4496.8875778105485, 4509.323601459774, 4510.932336014962, 4514.458265008204, 4349.826006959718, 4505.549445055484, 4512.9097418051615, 4518.774061296938, 4520.186366454037, 4399.648028157756, 4488.416505854234, 4506.909861802762, 4522.841700540482, 4533.773311334437, 4512.661550383735, 4513.526079761627, 4513.774311284439, 4517.367568540407, 4530.252508336121, 4010.5387880393546, 4011.7392369495888, 4014.5383280922774, 4020.5376381716183, 4024.255512730125, 5584.664920104766, 5590.357108932443, 5596.972015139939, 5597.0, 5606.467385598403, 5237.47625237477, 5244.5279924806955, 5249.055170069386, 5250.579953603741, 5269.1832765921345, 5974.701264936736, 6155.661438620874, 6158.9692051539905, 6163.3220345762375, 6170.321264660884, 4244.257254980366, 4251.766152861592, 4253.638440732541, 4267.359896015622, 4267.893302667427, 6382.234131904202, 6457.677116144174, 6464.999999999953, 6471.0, 6475.611463312216, 4402.427684401007, 4403.427554417905, 4404.977975110168, 4405.405270288534, 4407.228734971367, 4446.73319600825, 4456.286994080931, 4458.665600080007, 4459.375687403701, 4463.330500424962, 5080.485376600656, 5144.6913185209005, 5159.561437277798, 5197.1164901966, 5198.350206224222, 6139.84650383744, 6203.7828675996125, 6216.533759968021, 6244.406781355764, 6249.0938813871735, 1482.17739154768, 1516.8103987001625, 1531.3032570180542, 1567.1694002178863, 1569.0664054887325, 1011.1051719228535, 1020.4846552491093, 1032.488917985587, 1047.2041248650928, 1059.2902755154066, 5773.336066352424, 5787.160861675034, 5832.125181222766, 5832.795852145155, 5839.562032847553, 6334.5565810393755, 6351.301356850743, 6401.263854656681, 6424.775132870327, 6439.54923155384, 5790.073588225863, 5791.971040144772, 5793.333766616893, 5794.362620111784, 5808.854778630568, 3375.409303371949, 3379.1552111972005, 3381.425157723193, 3381.4758712399616, 3381.560397148355, 6243.562950593415, 6381.298057213796, 6400.807975760735, 6411.1024456576115, 6510.674466276667, 6331.778387756406, 6332.240131184288, 6383.106365108889, 6390.105385246069, 6395.232572091286, 6472.0291956206, 6477.740890364427, 6477.935220647733, 6481.773137940149, 6481.870362592722, 6196.597221180609, 6203.2245969253845, 6203.627782333075, 6208.379162083756, 6214.9689251553455, 6126.693665316628, 6200.100985357189, 6200.534959877937, 6205.22434695663, 6218.751249949952, 6542.934570654233, 6798.96600517014, 6804.863902721819, 6805.625690587065, 6808.0, 4398.318260669601, 4454.220511410425, 4456.598906098467, 4461.397711309061, 4473.552644735631, 6254.937450625435, 6322.051692246016, 6492.091107244895, 6501.577397469149, 6501.9674901625185, 6291.716872740646, 6299.685015749103, 6313.147725057059, 6319.9052014218905, 6320.431161195331, 6297.0, 6300.0234963580715, 6300.149479820166, 6305.5901366411035, 6308.463780578519, 6129.693515324305, 6144.446999770043, 6145.938540614537, 6147.0, 6150.292716337678, 6153.353897840662, 6293.3391993841815, 6312.4634406076, 6327.620342779263, 6333.683315834282, 6097.115918191926, 6139.631622102509, 6171.074338849208, 6177.351378105234, 6197.0], "unit": "score", "name": "prototype.html", "value": 4667.060479141159}, {"lowerIsBetter": false, "replicates": [738.8965544823723, 739.9223081576434, 752.6725874244704, 820.4379999700204, 830.829679915617, 13400.731985360288, 13722.862771372284, 13801.792973105412, 13881.930590347034, 13897.652558686037, 11762.823557646641, 13803.37884795184, 14174.787378189336, 14277.357518911647, 14383.568492945202, 672.4284358295434, 680.051328396886, 681.5263391942602, 826.8842362069315, 834.0366876257932, 678.0168755304803, 818.8607936650753, 834.670305229434, 835.761807884753, 837.0, 869.1482347299618, 869.9217070463657, 870.3559366069127, 870.5125129927229, 873.7640836974014, 711.5161690050763, 845.6490556419079, 856.4090777363631, 864.2222000199807, 871.6556960000796, 630.3853742600927, 631.2235949781794, 633.1357696743958, 633.556510442692, 634.1375729008545, 14068.944829137856, 14115.78826317606, 14155.646108847259, 14175.574732758034, 14177.291135443187, 13313.933430332883, 13538.203492377264, 13839.654008649764, 13963.930180349033, 13996.860031399658, 10470.895291047069, 10482.266241363108, 10827.455155054598, 10922.0, 10982.121430285559, 3620.31214069326, 3655.342038433081, 3666.211764470652, 3788.3181027415053, 3789.052736815796, 49597.25604115941, 51004.23493647598, 52858.47141528574, 53400.46599533994, 53424.46575534234, 10615.84076238857, 10793.406362649972, 10821.783564328827, 11083.334999900031, 11120.610778622871, 18751.718724219147, 18774.436766897015, 18775.0612469376, 18787.24851005972, 18815.529611759815, 7833.608319583998, 8050.0, 8105.27052565272, 8113.918860811316, 8120.918790812017, 4451.399061126771, 4581.587657110809, 4614.238650622677, 4638.7216766993415, 4643.164230438486, 3229.450993331139, 3257.2833976525126, 3259.3155437357946, 3270.378628060661, 3281.392942305681, 592.1059200607115, 592.1443514122138, 593.4303069053757, 595.7497850902545, 607.9240094988127, 648.9870202595922, 654.3603429955253, 661.5798967655477, 662.8243515468405, 665.8501837086617, 8633.525156116348, 8943.642254309885, 8986.68546600866, 9006.506903666053, 9182.127697868691, 613.8061470440041, 615.1971676961608, 618.7463140112623, 626.1828314050208, 629.9496040316856, 3672.081979505124, 3822.827972741233, 3832.5400951885954, 4005.818283606343, 4010.6991975601945, 56102.43897561054, 57538.71230643904, 57901.0, 57906.0, 58004.70997644985, 49626.503734962185, 50012.499875001515, 50104.749476252386, 51846.74076629593, 51984.74007629938, 45148.3227751584, 45498.31752523781, 47994.5200547997, 48257.27614085792, 49320.50679493159, 8401.579921004048, 8568.957155214184, 8654.394192406471, 8705.956470217609, 8829.64681412762, 37038.0, 37847.2430551393, 38488.80755596204, 40653.0, 40906.38640420337, 45172.32241516445, 45832.7708361456, 45896.0, 46150.769246154894, 48699.0, 11232.3260604364, 11275.718107047389, 11326.0, 11504.424778760862, 11648.592299269485, 11090.112790976542, 11242.775144497227, 11329.603463879055, 11347.886521134684, 12131.0, 11078.486227402771, 11279.15406344511, 11280.605178818701, 11615.6515304541, 11903.523859045541, 10658.253922225369, 10734.745703402374, 10771.569137234736, 11026.889731102907, 11181.776364472827, 10959.726006849893, 11183.105351571692, 11372.090232781524, 11613.245139065933, 11750.529978800752, 9735.951320243354, 9849.803003939738, 9958.253131015348, 10037.648682296085, 10046.196304295785, 9141.5886285116, 9145.222656074307, 9375.156235938799, 9977.10206081456, 10008.64969726056], "unit": "score", "name": "yui.html", "value": 6429.863437717072}], "name": "dromaeo_css", "value": 6899.974987202121}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 109.0, 110.0, 112.0, 112.0, 100.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 155.0, 174.0, 133.0, 156.0, 163.0, 131.0, 181.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 161.0, 159.0, 160.0, 161.0, 161.0, 163.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 102.0, 95.0, 75.0, 75.0, 73.0, 125.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 86.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 143.0, 97.0, 96.0, 98.0, 144.0, 96.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 116.0, 115.0, 114.0, 115.0, 115.0, 116.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.7}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.7}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 95.0, 97.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [60.0, 57.0, 56.0, 56.0, 56.0, 56.0, 58.0, 66.0, 54.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.3}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 67.0, 68.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.1}, {"lowerIsBetter": true, "replicates": [82.0, 81.0, 82.0, 82.0, 83.0, 83.0, 81.0, 82.0, 82.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [121.0, 115.0, 116.0, 113.0, 122.0, 114.0, 115.0, 120.0, 128.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [150.0, 138.0, 149.0, 150.0, 150.0, 146.0, 150.0, 150.0, 161.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 70.0, 69.0, 68.0, 67.0, 68.0, 69.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1515.4000000000003}]} 05:20:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1515.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6899.97"}}} 05:20:58 INFO - Return code: 0 05:20:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:20:58 INFO - # TBPL SUCCESS # 05:20:58 INFO - Running post-action listener: _resource_record_post_action 05:20:58 INFO - Running post-run listener: _resource_record_post_run 05:20:59 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 20480; Write bytes: 297381888; Read time: 24; Write time: 383128 05:20:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 6471680; Read time: 0; Write time: 2532 05:20:59 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 20480; Write bytes: 290910208; Read time: 24; Write time: 380596 05:20:59 INFO - Running post-run listener: _upload_blobber_files 05:20:59 INFO - Blob upload gear active. 05:20:59 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:20:59 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 05:20:59 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'] 05:20:59 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 05:20:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:20:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:20:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:20:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:21:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:01 INFO - (blobuploader) - INFO - Done attempting. 05:21:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:21:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:02 INFO - (blobuploader) - INFO - Done attempting. 05:21:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:02 INFO - Return code: 0 05:21:02 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:21:02 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e011ad12949a04533e02cf5ffd4460d4f42ba00d6e9fa98da2a0f82acb6dcfb02a3e3edcdf8775232eccbd0dd016003bb2ce503d0abf8c9cf063d713581ed8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb7b719f8f55881e72ba8a50f4beb1ef986fd772a4c861a97d9b8d8ed5bc4ed36e9bc0b330d3eaa0bd7515057801d65f8ba5ab9c256704d702171b1a5e7f8487"} 05:21:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:21:02 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:21:02 INFO - Contents: 05:21:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e011ad12949a04533e02cf5ffd4460d4f42ba00d6e9fa98da2a0f82acb6dcfb02a3e3edcdf8775232eccbd0dd016003bb2ce503d0abf8c9cf063d713581ed8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb7b719f8f55881e72ba8a50f4beb1ef986fd772a4c861a97d9b8d8ed5bc4ed36e9bc0b330d3eaa0bd7515057801d65f8ba5ab9c256704d702171b1a5e7f8487"} 05:21:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:21:02 INFO - Copying logs to upload dir... 05:21:02 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:21:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.373560 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-02-22 05:21:02.646942) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 05:21:02.650644) ========= 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e011ad12949a04533e02cf5ffd4460d4f42ba00d6e9fa98da2a0f82acb6dcfb02a3e3edcdf8775232eccbd0dd016003bb2ce503d0abf8c9cf063d713581ed8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb7b719f8f55881e72ba8a50f4beb1ef986fd772a4c861a97d9b8d8ed5bc4ed36e9bc0b330d3eaa0bd7515057801d65f8ba5ab9c256704d702171b1a5e7f8487"} build_url:https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009892 build_url: 'https://queue.taskcluster.net/v1/task/Sd8Ur-LCQr2Lhgf7BBD7vQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61e011ad12949a04533e02cf5ffd4460d4f42ba00d6e9fa98da2a0f82acb6dcfb02a3e3edcdf8775232eccbd0dd016003bb2ce503d0abf8c9cf063d713581ed8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fb7b719f8f55881e72ba8a50f4beb1ef986fd772a4c861a97d9b8d8ed5bc4ed36e9bc0b330d3eaa0bd7515057801d65f8ba5ab9c256704d702171b1a5e7f8487"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 05:21:02.671780) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:21:02.672110) ========= 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=df17445c3590ff7897617a0e00000225-1456144673.440406-1937538420 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 05:21:02.755027) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 05:21:02.755344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 05:21:02.755622) ========= ========= Total master_lag: 0.22 =========