builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-017 starttime: 1454807354.83 results: success (0) buildid: 20160206143004 builduid: 06c7deda69de487aabea37d6c69bbb0c revision: 281de9bf9ff6f22882f614d8ea443dfed007e9c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.830377) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.830816) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.831136) ========= 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006264 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.867561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.867861) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.885493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.885776) ========= 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.939927) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.940238) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.940617) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:14.940956) ========= 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-06 17:09:14-- 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% 64.6M=0s 2016-02-06 17:09:15 (64.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.125276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.125609) ========= 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015305 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.176399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.176790) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 281de9bf9ff6f22882f614d8ea443dfed007e9c4 --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 281de9bf9ff6f22882f614d8ea443dfed007e9c4 --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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-06 17:09:15,230 truncating revision to first 12 chars 2016-02-06 17:09:15,230 Setting DEBUG logging. 2016-02-06 17:09:15,231 attempt 1/10 2016-02-06 17:09:15,231 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/281de9bf9ff6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-06 17:09:15,540 unpacking tar archive at: fx-team-281de9bf9ff6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.599167 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.791057) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.791411) ========= echo 281de9bf9ff6f22882f614d8ea443dfed007e9c4 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'281de9bf9ff6f22882f614d8ea443dfed007e9c4'] 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 281de9bf9ff6f22882f614d8ea443dfed007e9c4 program finished with exit code 0 elapsedTime=0.003664 script_repo_revision: '281de9bf9ff6f22882f614d8ea443dfed007e9c4' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.839966) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.840309) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-06 17:09:15.850670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-06 17:09:15.850998) ========= /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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:09:15 INFO - MultiFileLogger online at 20160206 17:09:15 in /builds/slave/test-pgo 17:09:15 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 17:09:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:09:15 INFO - {'append_to_log': False, 17:09:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:09:15 INFO - 'blob_upload_branch': 'Fx-Team', 17:09:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:09:15 INFO - 'branch': 'Fx-Team', 17:09:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:09:15 INFO - 'config_files': ('talos/linux_config.py',), 17:09:16 INFO - 'default_actions': ('clobber', 17:09:16 INFO - 'read-buildbot-config', 17:09:16 INFO - 'download-and-extract', 17:09:16 INFO - 'populate-webroot', 17:09:16 INFO - 'create-virtualenv', 17:09:16 INFO - 'install', 17:09:16 INFO - 'run-tests'), 17:09:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:09:16 INFO - 'download_minidump_stackwalk': True, 17:09:16 INFO - 'download_symbols': 'ondemand', 17:09:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:09:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:09:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:09:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:09:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:09:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:09:16 INFO - 'installer_path': 'installer.exe', 17:09:16 INFO - 'log_level': 'info', 17:09:16 INFO - 'log_name': 'talos', 17:09:16 INFO - 'log_to_console': True, 17:09:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:09:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:09:16 INFO - 'opt_config_files': (), 17:09:16 INFO - 'pip_index': False, 17:09:16 INFO - 'sps_profile': False, 17:09:16 INFO - 'sps_profile_interval': 0, 17:09:16 INFO - 'suite': 'dromaeojs', 17:09:16 INFO - 'system_bits': '32', 17:09:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:09:16 INFO - 'title': 'talos-linux64-ix-017', 17:09:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:09:16 INFO - 'use_talos_json': True, 17:09:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:09:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:09:16 INFO - 'work_dir': 'build'} 17:09:16 INFO - ##### 17:09:16 INFO - ##### Running clobber step. 17:09:16 INFO - ##### 17:09:16 INFO - Running pre-action listener: _resource_record_pre_action 17:09:16 INFO - Running main action method: clobber 17:09:16 INFO - rmtree: /builds/slave/test-pgo/build 17:09:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:09:16 INFO - Running post-action listener: _resource_record_post_action 17:09:16 INFO - ##### 17:09:16 INFO - ##### Running read-buildbot-config step. 17:09:16 INFO - ##### 17:09:16 INFO - Running pre-action listener: _resource_record_pre_action 17:09:16 INFO - Running main action method: read_buildbot_config 17:09:16 INFO - Using buildbot properties: 17:09:16 INFO - { 17:09:16 INFO - "project": "", 17:09:16 INFO - "product": "firefox", 17:09:16 INFO - "script_repo_revision": "production", 17:09:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:09:16 INFO - "repository": "", 17:09:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:09:16 INFO - "buildid": "20160206143004", 17:09:16 INFO - "pgo_build": "True", 17:09:16 INFO - "basedir": "/builds/slave/test-pgo", 17:09:16 INFO - "buildnumber": 632, 17:09:16 INFO - "slavename": "talos-linux64-ix-017", 17:09:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:09:16 INFO - "platform": "ubuntu64_hw", 17:09:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:09:16 INFO - "branch": "fx-team", 17:09:16 INFO - "repo_path": "integration/fx-team", 17:09:16 INFO - "revision": "281de9bf9ff6f22882f614d8ea443dfed007e9c4", 17:09:16 INFO - "stage_platform": "linux64-pgo", 17:09:16 INFO - "builduid": "06c7deda69de487aabea37d6c69bbb0c", 17:09:16 INFO - "slavebuilddir": "test" 17:09:16 INFO - } 17:09:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 17:09:16 INFO - Running post-action listener: _resource_record_post_action 17:09:16 INFO - ##### 17:09:16 INFO - ##### Running download-and-extract step. 17:09:16 INFO - ##### 17:09:16 INFO - Running pre-action listener: _resource_record_pre_action 17:09:16 INFO - Running main action method: download_and_extract 17:09:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:16 INFO - https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:09:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/test_packages.json 17:09:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/test_packages.json 17:09:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:09:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:09:26 INFO - Downloaded 1448 bytes. 17:09:26 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:09:26 INFO - Using the following test package requirements: 17:09:26 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:26 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:09:26 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:09:26 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'jsshell-linux-x86_64.zip'], 17:09:26 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:09:26 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:26 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:09:26 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:09:26 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:09:26 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 17:09:26 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 17:09:26 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:09:26 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:09: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')]} 17:09:26 INFO - https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:34 INFO - Downloaded 23573270 bytes. 17:09:34 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'] 17:09:34 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 17:09:35 INFO - Return code: 0 17:09:35 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 17:09:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:35 INFO - https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:09:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 17:09:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:37 INFO - Downloaded 23573270 bytes. 17:09:37 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'] 17:09:37 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 17:09:38 INFO - Return code: 0 17:09:38 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')]} 17:09:38 INFO - https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:09:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 17:09:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:39 INFO - Downloaded 10706547 bytes. 17:09:39 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'] 17:09:39 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 17:09:39 INFO - Return code: 0 17:09: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')]} 17:09:39 INFO - https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:09:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HleVtxlsRmSBm8TBPWidhQ/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 17:09:41 INFO - Downloaded 56528620 bytes. 17:09:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:41 INFO - mkdir: /builds/slave/test-pgo/properties 17:09:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:09:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:09:41 INFO - Contents: 17:09:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 17:09:42 INFO - Running post-action listener: _resource_record_post_action 17:09:42 INFO - Running post-action listener: set_extra_try_arguments 17:09:42 INFO - ##### 17:09:42 INFO - ##### Running populate-webroot step. 17:09:42 INFO - ##### 17:09:42 INFO - Running pre-action listener: _resource_record_pre_action 17:09:42 INFO - Running main action method: populate_webroot 17:09:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:09:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:09:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:09:42 INFO - '--tppagecycles', 17:09:42 INFO - '7'], 17:09:42 INFO - 'tests': ['tsvgm']}}, 17:09:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:09:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:09:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:09:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:09:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:09:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'tests': ['damp', 'tps']}, 17:09:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['damp', 'tps']}, 17:09:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:09:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:09:42 INFO - 'other': {'tests': ['a11yr', 17:09:42 INFO - 'ts_paint', 17:09:42 INFO - 'tpaint', 17:09:42 INFO - 'sessionrestore', 17:09:42 INFO - 'sessionrestore_no_auto_restore']}, 17:09:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['a11yr', 17:09:42 INFO - 'ts_paint', 17:09:42 INFO - 'tpaint', 17:09:42 INFO - 'sessionrestore', 17:09:42 INFO - 'sessionrestore_no_auto_restore']}, 17:09:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['a11yr', 17:09:42 INFO - 'ts_paint', 17:09:42 INFO - 'tpaint', 17:09:42 INFO - 'sessionrestore', 17:09:42 INFO - 'sessionrestore_no_auto_restore']}, 17:09:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['a11yr', 17:09:42 INFO - 'ts_paint', 17:09:42 INFO - 'tpaint', 17:09:42 INFO - 'sessionrestore', 17:09:42 INFO - 'sessionrestore_no_auto_restore']}, 17:09:42 INFO - 'other_l64': {'tests': ['a11yr', 17:09:42 INFO - 'ts_paint', 17:09:42 INFO - 'tpaint', 17:09:42 INFO - 'sessionrestore', 17:09:42 INFO - 'sessionrestore_no_auto_restore']}, 17:09:42 INFO - 'other_nol64': {'tests': ['a11yr', 17:09:42 INFO - 'ts_paint', 17:09:42 INFO - 'tpaint', 17:09:42 INFO - 'sessionrestore', 17:09:42 INFO - 'sessionrestore_no_auto_restore']}, 17:09:42 INFO - 'svgr': {'tests': ['tsvgx', 17:09:42 INFO - 'tsvgr_opacity', 17:09:42 INFO - 'tart', 17:09:42 INFO - 'tscrollx', 17:09:42 INFO - 'cart']}, 17:09:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['tsvgx', 17:09:42 INFO - 'tsvgr_opacity', 17:09:42 INFO - 'tart', 17:09:42 INFO - 'tscrollx', 17:09:42 INFO - 'cart']}, 17:09:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'tests': ['tp5o']}, 17:09:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'talos_options': ['--e10s'], 17:09:42 INFO - 'tests': ['tp5o']}, 17:09:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'talos_options': ['--xperf_path', 17:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:42 INFO - 'tests': ['tp5n']}, 17:09:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:09:42 INFO - 'talos_options': ['--e10s', 17:09:42 INFO - '--xperf_path', 17:09:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:09:42 INFO - 'tests': ['tp5n']}}, 17:09:42 INFO - 'talos.zip': {'path': '', 17:09:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:09:42 INFO - Running post-action listener: _resource_record_post_action 17:09:42 INFO - ##### 17:09:42 INFO - ##### Running create-virtualenv step. 17:09:42 INFO - ##### 17:09:42 INFO - Running pre-action listener: _resource_record_pre_action 17:09:42 INFO - Running main action method: create_virtualenv 17:09:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:09:42 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 17:09:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:09:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:09:42 INFO - Using real prefix '/usr' 17:09:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:09:42 INFO - Installing distribute.............................................................................................................................................................................................done. 17:09:44 INFO - Installing pip.................done. 17:09:44 INFO - Return code: 0 17:09:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 17:09:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:09:44 INFO - Using env: {'DISPLAY': ':0', 17:09:44 INFO - 'HOME': '/home/cltbld', 17:09:44 INFO - 'LANG': 'en_US.UTF-8', 17:09:44 INFO - 'LANGUAGE': 'en_US:en', 17:09:44 INFO - 'LOGNAME': 'cltbld', 17:09:44 INFO - 'MAIL': '/var/mail/cltbld', 17:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:44 INFO - 'MOZ_NO_REMOTE': '1', 17:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:44 INFO - 'NO_EM_RESTART': '1', 17:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:44 INFO - 'SHELL': '/bin/bash', 17:09:44 INFO - 'SHLVL': '1', 17:09:44 INFO - 'TERM': 'linux', 17:09:44 INFO - 'TMOUT': '86400', 17:09:44 INFO - 'USER': 'cltbld', 17:09:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:44 INFO - '_': '/tools/buildbot/bin/python'} 17:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:44 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 17:09:44 INFO - Cleaning up... 17:09:44 INFO - Return code: 0 17:09:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 17:09:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:09:44 INFO - Using env: {'DISPLAY': ':0', 17:09:44 INFO - 'HOME': '/home/cltbld', 17:09:44 INFO - 'LANG': 'en_US.UTF-8', 17:09:44 INFO - 'LANGUAGE': 'en_US:en', 17:09:44 INFO - 'LOGNAME': 'cltbld', 17:09:44 INFO - 'MAIL': '/var/mail/cltbld', 17:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:44 INFO - 'MOZ_NO_REMOTE': '1', 17:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:44 INFO - 'NO_EM_RESTART': '1', 17:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:44 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:44 INFO - 'SHELL': '/bin/bash', 17:09:44 INFO - 'SHLVL': '1', 17:09:44 INFO - 'TERM': 'linux', 17:09:44 INFO - 'TMOUT': '86400', 17:09:44 INFO - 'USER': 'cltbld', 17:09:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:44 INFO - '_': '/tools/buildbot/bin/python'} 17:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:45 INFO - Downloading/unpacking psutil>=0.7.1 17:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:47 INFO - Installing collected packages: psutil 17:09:47 INFO - Running setup.py install for psutil 17:09:47 INFO - building 'psutil._psutil_linux' extension 17:09:47 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 17:09:47 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 17:09:47 INFO - building 'psutil._psutil_posix' extension 17:09:47 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 17:09:47 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 17:09:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:09:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:09:47 INFO - Successfully installed psutil 17:09:47 INFO - Cleaning up... 17:09:47 INFO - Return code: 0 17:09:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:09: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')]} 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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')]} 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09: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', '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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 17:09: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 mozsystemmonitor==0.0.0 17:09:47 INFO - Using env: {'DISPLAY': ':0', 17:09:47 INFO - 'HOME': '/home/cltbld', 17:09:47 INFO - 'LANG': 'en_US.UTF-8', 17:09:47 INFO - 'LANGUAGE': 'en_US:en', 17:09:47 INFO - 'LOGNAME': 'cltbld', 17:09:47 INFO - 'MAIL': '/var/mail/cltbld', 17:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:47 INFO - 'MOZ_NO_REMOTE': '1', 17:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:47 INFO - 'NO_EM_RESTART': '1', 17:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:47 INFO - 'SHELL': '/bin/bash', 17:09:47 INFO - 'SHLVL': '1', 17:09:47 INFO - 'TERM': 'linux', 17:09:47 INFO - 'TMOUT': '86400', 17:09:47 INFO - 'USER': 'cltbld', 17:09:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:47 INFO - '_': '/tools/buildbot/bin/python'} 17:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:09:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:09:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:09:49 INFO - Installing collected packages: mozsystemmonitor 17:09:49 INFO - Running setup.py install for mozsystemmonitor 17:09:49 INFO - Successfully installed mozsystemmonitor 17:09:49 INFO - Cleaning up... 17:09:49 INFO - Return code: 0 17:09:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:09:49 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')]} 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 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')]} 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:49 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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09:49 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 17:09:49 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 17:09:49 INFO - Using env: {'DISPLAY': ':0', 17:09:49 INFO - 'HOME': '/home/cltbld', 17:09:49 INFO - 'LANG': 'en_US.UTF-8', 17:09:49 INFO - 'LANGUAGE': 'en_US:en', 17:09:49 INFO - 'LOGNAME': 'cltbld', 17:09:49 INFO - 'MAIL': '/var/mail/cltbld', 17:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:49 INFO - 'MOZ_NO_REMOTE': '1', 17:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:49 INFO - 'NO_EM_RESTART': '1', 17:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:49 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:49 INFO - 'SHELL': '/bin/bash', 17:09:49 INFO - 'SHLVL': '1', 17:09:49 INFO - 'TERM': 'linux', 17:09:49 INFO - 'TMOUT': '86400', 17:09:49 INFO - 'USER': 'cltbld', 17:09:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:49 INFO - '_': '/tools/buildbot/bin/python'} 17:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:49 INFO - Downloading/unpacking blobuploader==1.2.4 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:51 INFO - Downloading blobuploader-1.2.4.tar.gz 17:09:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:09:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:09:51 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 17:09:51 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 17:09:51 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 17:09:51 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 17:09:51 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 17:09:51 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 17:09:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:09:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:52 INFO - Downloading docopt-0.6.1.tar.gz 17:09:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:09:52 INFO - Installing collected packages: blobuploader, requests, docopt 17:09:52 INFO - Running setup.py install for blobuploader 17:09:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:09:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:09:52 INFO - Running setup.py install for requests 17:09:52 INFO - Running setup.py install for docopt 17:09:53 INFO - Successfully installed blobuploader requests docopt 17:09:53 INFO - Cleaning up... 17:09:53 INFO - Return code: 0 17:09:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:53 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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09:53 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 17:09:53 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 17:09:53 INFO - Using env: {'DISPLAY': ':0', 17:09:53 INFO - 'HOME': '/home/cltbld', 17:09:53 INFO - 'LANG': 'en_US.UTF-8', 17:09:53 INFO - 'LANGUAGE': 'en_US:en', 17:09:53 INFO - 'LOGNAME': 'cltbld', 17:09:53 INFO - 'MAIL': '/var/mail/cltbld', 17:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:53 INFO - 'MOZ_NO_REMOTE': '1', 17:09:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:53 INFO - 'NO_EM_RESTART': '1', 17:09:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:53 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:53 INFO - 'SHELL': '/bin/bash', 17:09:53 INFO - 'SHLVL': '1', 17:09:53 INFO - 'TERM': 'linux', 17:09:53 INFO - 'TMOUT': '86400', 17:09:53 INFO - 'USER': 'cltbld', 17:09:53 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:53 INFO - '_': '/tools/buildbot/bin/python'} 17:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:53 INFO - Running setup.py (path:/tmp/pip-rlbjWB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:53 INFO - Running setup.py (path:/tmp/pip-hGsprK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:53 INFO - Running setup.py (path:/tmp/pip-jg2kRm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:53 INFO - Running setup.py (path:/tmp/pip-L_piKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:53 INFO - Running setup.py (path:/tmp/pip-kQWFXM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:53 INFO - Running setup.py (path:/tmp/pip-QIVkcf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:53 INFO - Running setup.py (path:/tmp/pip-hHRL0K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:53 INFO - Running setup.py (path:/tmp/pip-jzCzWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:53 INFO - Running setup.py (path:/tmp/pip-y_WQkG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:53 INFO - Running setup.py (path:/tmp/pip-LGIzN7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:54 INFO - Running setup.py (path:/tmp/pip-LUjBIG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:54 INFO - Running setup.py (path:/tmp/pip-ztk3lm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:54 INFO - Running setup.py (path:/tmp/pip-CQZGIo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:54 INFO - Running setup.py (path:/tmp/pip-Du6xNC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:54 INFO - Running setup.py (path:/tmp/pip-W1Tgov-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:54 INFO - Running setup.py (path:/tmp/pip-Z8whrr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:54 INFO - Running setup.py (path:/tmp/pip-xLXxj1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:09:54 INFO - Running setup.py install for manifestparser 17:09:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:09:54 INFO - Running setup.py install for mozcrash 17:09:54 INFO - Running setup.py install for mozdebug 17:09:54 INFO - Running setup.py install for mozdevice 17:09:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:09:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:09:54 INFO - Running setup.py install for mozfile 17:09:55 INFO - Running setup.py install for mozhttpd 17:09:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Running setup.py install for mozinfo 17:09:55 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Running setup.py install for mozInstall 17:09:55 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Running setup.py install for mozleak 17:09:55 INFO - Running setup.py install for mozlog 17:09:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Running setup.py install for moznetwork 17:09:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Running setup.py install for mozprocess 17:09:55 INFO - Running setup.py install for mozprofile 17:09:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:09:55 INFO - Running setup.py install for mozrunner 17:09:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:09:56 INFO - Running setup.py install for mozscreenshot 17:09:56 INFO - Running setup.py install for moztest 17:09:56 INFO - Running setup.py install for mozversion 17:09:56 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:09:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:09:56 INFO - Cleaning up... 17:09:56 INFO - Return code: 0 17:09:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:56 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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09:56 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 17:09:56 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 17:09:56 INFO - Using env: {'DISPLAY': ':0', 17:09:56 INFO - 'HOME': '/home/cltbld', 17:09:56 INFO - 'LANG': 'en_US.UTF-8', 17:09:56 INFO - 'LANGUAGE': 'en_US:en', 17:09:56 INFO - 'LOGNAME': 'cltbld', 17:09:56 INFO - 'MAIL': '/var/mail/cltbld', 17:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:56 INFO - 'MOZ_NO_REMOTE': '1', 17:09:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:56 INFO - 'NO_EM_RESTART': '1', 17:09:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:56 INFO - 'SHELL': '/bin/bash', 17:09:56 INFO - 'SHLVL': '1', 17:09:56 INFO - 'TERM': 'linux', 17:09:56 INFO - 'TMOUT': '86400', 17:09:56 INFO - 'USER': 'cltbld', 17:09:56 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:56 INFO - '_': '/tools/buildbot/bin/python'} 17:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:56 INFO - Running setup.py (path:/tmp/pip-oGiJwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:09:56 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)) 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:56 INFO - Running setup.py (path:/tmp/pip-0o1ZUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:09:56 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)) 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:56 INFO - Running setup.py (path:/tmp/pip-47hNfG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:09:56 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)) 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:56 INFO - Running setup.py (path:/tmp/pip-eR4Frd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:09:56 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)) 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:56 INFO - Running setup.py (path:/tmp/pip-HPV1gE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:09:56 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)) 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:56 INFO - Running setup.py (path:/tmp/pip-_kkjxT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:09:56 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)) 17:09:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:56 INFO - Running setup.py (path:/tmp/pip-Udsqyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:57 INFO - Running setup.py (path:/tmp/pip-5MOJfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:57 INFO - Running setup.py (path:/tmp/pip-O0OmqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:57 INFO - Running setup.py (path:/tmp/pip-beIToW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:57 INFO - Running setup.py (path:/tmp/pip-Pxn_E0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:57 INFO - Running setup.py (path:/tmp/pip-xPzl8B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:57 INFO - Running setup.py (path:/tmp/pip-L1VWFo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:57 INFO - Running setup.py (path:/tmp/pip-wJt_Wk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:57 INFO - Running setup.py (path:/tmp/pip-LPSAR9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:57 INFO - Running setup.py (path:/tmp/pip-ZWamID-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:09:57 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)) 17:09:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:57 INFO - Running setup.py (path:/tmp/pip-LqIO7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:09:57 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)) 17:09:57 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)) 17:09:57 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)) 17:09:57 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)) 17:09:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 17:09:57 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)) 17:09:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:09:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:09:59 INFO - Downloading blessings-1.6.tar.gz 17:09:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:09:59 INFO - Installing collected packages: blessings 17:09:59 INFO - Running setup.py install for blessings 17:09:59 INFO - Successfully installed blessings 17:09:59 INFO - Cleaning up... 17:09:59 INFO - Return code: 0 17:09:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:09:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:09:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:09:59 INFO - Reading from file tmpfile_stdout 17:09:59 INFO - Current package versions: 17:09:59 INFO - argparse == 1.2.1 17:09:59 INFO - blessings == 1.6 17:09:59 INFO - blobuploader == 1.2.4 17:09:59 INFO - docopt == 0.6.1 17:09:59 INFO - manifestparser == 1.1 17:09:59 INFO - mozInstall == 1.12 17:09:59 INFO - mozcrash == 0.16 17:09:59 INFO - mozdebug == 0.1 17:09:59 INFO - mozdevice == 0.48 17:09:59 INFO - mozfile == 1.2 17:09:59 INFO - mozhttpd == 0.7 17:09:59 INFO - mozinfo == 0.9 17:09:59 INFO - mozleak == 0.1 17:09:59 INFO - mozlog == 3.1 17:09:59 INFO - moznetwork == 0.27 17:09:59 INFO - mozprocess == 0.22 17:09:59 INFO - mozprofile == 0.28 17:09:59 INFO - mozrunner == 6.11 17:09:59 INFO - mozscreenshot == 0.1 17:09:59 INFO - mozsystemmonitor == 0.0 17:09:59 INFO - moztest == 0.7 17:09:59 INFO - mozversion == 1.4 17:09:59 INFO - psutil == 3.1.1 17:09:59 INFO - requests == 1.2.3 17:09:59 INFO - wsgiref == 0.1.2 17:09:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:09:59 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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:09:59 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 17:09:59 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 17:09:59 INFO - Using env: {'DISPLAY': ':0', 17:09:59 INFO - 'HOME': '/home/cltbld', 17:09:59 INFO - 'LANG': 'en_US.UTF-8', 17:09:59 INFO - 'LANGUAGE': 'en_US:en', 17:09:59 INFO - 'LOGNAME': 'cltbld', 17:09:59 INFO - 'MAIL': '/var/mail/cltbld', 17:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:09:59 INFO - 'MOZ_NO_REMOTE': '1', 17:09:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:09:59 INFO - 'NO_EM_RESTART': '1', 17:09:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:09:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:09:59 INFO - 'SHELL': '/bin/bash', 17:09:59 INFO - 'SHLVL': '1', 17:09:59 INFO - 'TERM': 'linux', 17:09:59 INFO - 'TMOUT': '86400', 17:09:59 INFO - 'USER': 'cltbld', 17:09:59 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:09:59 INFO - '_': '/tools/buildbot/bin/python'} 17:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 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)) 17:10:00 INFO - Cleaning up... 17:10:00 INFO - Return code: 0 17:10:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:10:00 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')]} 17:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:00 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')]} 17:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:00 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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:10:00 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 17:10:00 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 17:10:00 INFO - Using env: {'DISPLAY': ':0', 17:10:00 INFO - 'HOME': '/home/cltbld', 17:10:00 INFO - 'LANG': 'en_US.UTF-8', 17:10:00 INFO - 'LANGUAGE': 'en_US:en', 17:10:00 INFO - 'LOGNAME': 'cltbld', 17:10:00 INFO - 'MAIL': '/var/mail/cltbld', 17:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:00 INFO - 'MOZ_NO_REMOTE': '1', 17:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:00 INFO - 'NO_EM_RESTART': '1', 17:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:10:00 INFO - 'PWD': '/builds/slave/test-pgo', 17:10:00 INFO - 'SHELL': '/bin/bash', 17:10:00 INFO - 'SHLVL': '1', 17:10:00 INFO - 'TERM': 'linux', 17:10:00 INFO - 'TMOUT': '86400', 17:10:00 INFO - 'USER': 'cltbld', 17:10:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:00 INFO - '_': '/tools/buildbot/bin/python'} 17:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:00 INFO - Downloading/unpacking jsonschema 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10: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 17:10:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:10:02 INFO - Downloading/unpacking functools32 (from jsonschema) 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:02 INFO - Downloading functools32-3.2.3-2.tar.gz 17:10:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:10:02 INFO - warning: no files found matching '*.txt' 17:10:02 INFO - no previously-included directories found matching 'build' 17:10:02 INFO - no previously-included directories found matching 'dist' 17:10:02 INFO - no previously-included directories found matching '.git*' 17:10:02 INFO - Installing collected packages: jsonschema, functools32 17:10:02 INFO - Running setup.py install for functools32 17:10:02 INFO - warning: no files found matching '*.txt' 17:10:02 INFO - no previously-included directories found matching 'build' 17:10:02 INFO - no previously-included directories found matching 'dist' 17:10:02 INFO - no previously-included directories found matching '.git*' 17:10:02 INFO - Successfully installed jsonschema functools32 17:10:02 INFO - Cleaning up... 17:10:02 INFO - Return code: 0 17:10:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:10:02 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')]} 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:02 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')]} 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:10:02 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 0x7fefe5655f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e2630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, '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': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', '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 17:10:02 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 17:10:02 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 17:10:02 INFO - Using env: {'DISPLAY': ':0', 17:10:02 INFO - 'HOME': '/home/cltbld', 17:10:02 INFO - 'LANG': 'en_US.UTF-8', 17:10:02 INFO - 'LANGUAGE': 'en_US:en', 17:10:02 INFO - 'LOGNAME': 'cltbld', 17:10:02 INFO - 'MAIL': '/var/mail/cltbld', 17:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:02 INFO - 'MOZ_NO_REMOTE': '1', 17:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:02 INFO - 'NO_EM_RESTART': '1', 17:10:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:10:02 INFO - 'PWD': '/builds/slave/test-pgo', 17:10:02 INFO - 'SHELL': '/bin/bash', 17:10:02 INFO - 'SHLVL': '1', 17:10:02 INFO - 'TERM': 'linux', 17:10:02 INFO - 'TMOUT': '86400', 17:10:02 INFO - 'USER': 'cltbld', 17:10:02 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:02 INFO - '_': '/tools/buildbot/bin/python'} 17:10:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:10:02 INFO - Downloading/unpacking flake8 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:10:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:10:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:10:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:04 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 17:10:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 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 17:10:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:10:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:05 INFO - no previously-included directories found matching 'docs/_build' 17:10:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:10:05 INFO - Running setup.py install for pep8 17:10:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:10:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:10:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:10:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:10:05 INFO - no previously-included directories found matching 'docs/_build' 17:10:05 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:10:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:10:05 INFO - Cleaning up... 17:10:05 INFO - Return code: 0 17:10:05 INFO - Running post-action listener: _resource_record_post_action 17:10:05 INFO - Running post-action listener: _start_resource_monitoring 17:10:05 INFO - Starting resource monitoring. 17:10:05 INFO - ##### 17:10:05 INFO - ##### Running install step. 17:10:05 INFO - ##### 17:10:05 INFO - Running pre-action listener: _resource_record_pre_action 17:10:05 INFO - Running main action method: install 17:10:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:10:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:10:05 INFO - Reading from file tmpfile_stdout 17:10:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:10:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:10:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:10:05 INFO - Reading from file tmpfile_stdout 17:10:05 INFO - Output received: 17:10:05 INFO - Usage: mozinstall [options] installer 17:10:05 INFO - Options: 17:10:05 INFO - -h, --help show this help message and exit 17:10:05 INFO - -d DEST, --destination=DEST 17:10:05 INFO - Directory to install application into. [default: 17:10:05 INFO - "/builds/slave/test-pgo"] 17:10:05 INFO - --app=APP Application being installed. [default: firefox] 17:10:05 INFO - mkdir: /builds/slave/test-pgo/build/application 17:10:05 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'] 17:10:05 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 17:10:22 INFO - Reading from file tmpfile_stdout 17:10:22 INFO - Output received: 17:10:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:10:22 INFO - Running post-action listener: _resource_record_post_action 17:10:22 INFO - ##### 17:10:22 INFO - ##### Running run-tests step. 17:10:22 INFO - ##### 17:10:22 INFO - Running pre-action listener: _resource_record_pre_action 17:10:22 INFO - Running main action method: run_tests 17:10:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:10:22 INFO - Python 2.7.3 17:10:22 INFO - Return code: 0 17:10:22 INFO - grabbing minidump binary from tooltool 17:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:10:22 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 0x1473840>, '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 0x13e06b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13e0b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:10:22 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 17:10:22 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 17:10:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:10:22 INFO - Return code: 0 17:10:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:10:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:10:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:10:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:10:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:10:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:10:23 INFO - Return code: 0 17:10:23 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/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 17:10:23 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/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 17:10:23 INFO - Using env: {'DISPLAY': ':0', 17:10:23 INFO - 'HOME': '/home/cltbld', 17:10:23 INFO - 'LANG': 'en_US.UTF-8', 17:10:23 INFO - 'LANGUAGE': 'en_US:en', 17:10:23 INFO - 'LOGNAME': 'cltbld', 17:10:23 INFO - 'MAIL': '/var/mail/cltbld', 17:10:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:10:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:10:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:10:23 INFO - 'MOZ_NO_REMOTE': '1', 17:10:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:10:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:10:23 INFO - 'NO_EM_RESTART': '1', 17:10:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:10:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:10:23 INFO - 'PWD': '/builds/slave/test-pgo', 17:10:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:10:23 INFO - 'SHELL': '/bin/bash', 17:10:23 INFO - 'SHLVL': '1', 17:10:23 INFO - 'TERM': 'linux', 17:10:23 INFO - 'TMOUT': '86400', 17:10:23 INFO - 'USER': 'cltbld', 17:10:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965', 17:10:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:10:23 INFO - '_': '/tools/buildbot/bin/python'} 17:10:23 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/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 17:10:23 INFO - mozversion application_buildid: 20160206143004 17:10:23 INFO - mozversion application_changeset: 281de9bf9ff6f22882f614d8ea443dfed007e9c4 17:10:23 INFO - mozversion application_display_name: Nightly 17:10:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:10:23 INFO - mozversion application_name: Firefox 17:10:23 INFO - mozversion application_remotingname: firefox 17:10:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:10:23 INFO - mozversion application_vendor: Mozilla 17:10:23 INFO - mozversion application_version: 47.0a1 17:10:23 INFO - mozversion platform_buildid: 20160206143004 17:10:23 INFO - mozversion platform_changeset: 281de9bf9ff6f22882f614d8ea443dfed007e9c4 17:10:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:10:23 INFO - mozversion platform_version: 47.0a1 17:10:23 INFO - using testdate: 1454807423 17:10:23 INFO - actual date: 1454807423 17:10:23 INFO - starting webserver on 'localhost:36674' 17:10:23 INFO - SUITE-START | Running 2 tests 17:10:23 INFO - TEST-START | dromaeo_css 17:10:23 INFO - operating with platform_type : linux_ 17:10:23 INFO - Initialising browser for dromaeo_css test... 17:10:23 INFO - TEST-INFO | started process 3888 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSTjhAo/profile http://localhost:36674/getInfo.html) 17:10:27 INFO - PROCESS | 3888 | __metrics Screen width/height:1600/1200 17:10:27 INFO - PROCESS | 3888 | colorDepth:24 17:10:27 INFO - PROCESS | 3888 | Browser inner width/height: 1024/697 17:10:27 INFO - PROCESS | 3888 | __metrics 17:10:27 INFO - PROCESS | 3888 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:10:28 INFO - TEST-INFO | 3888: exit 0 17:10:28 INFO - Browser initialized. 17:10:28 INFO - Running cycle 1/1 for dromaeo_css test... 17:10:28 INFO - TEST-INFO | started process 3978 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSTjhAo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:40 INFO - PROCESS | 3978 | RSS: Main: 151937024 17:10:40 INFO - PROCESS | 3978 | 17:11:32 INFO - PROCESS | 3978 | 1454807492102 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] 17:13:40 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36674/tests/dromaeo/cssquery-ext.html) 17:13:41 INFO - PROCESS | 3978 | RSS: Main: 261578752 17:13:41 INFO - PROCESS | 3978 | 17:16:43 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36674/tests/dromaeo/cssquery-ext.html (next: http://localhost:36674/tests/dromaeo/cssquery-jquery.html) 17:16:44 INFO - PROCESS | 3978 | RSS: Main: 239509504 17:16:44 INFO - PROCESS | 3978 | 17:19:46 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36674/tests/dromaeo/cssquery-mootools.html) 17:19:47 INFO - PROCESS | 3978 | RSS: Main: 241414144 17:19:47 INFO - PROCESS | 3978 | 17:22:49 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36674/tests/dromaeo/cssquery-prototype.html) 17:22:49 INFO - PROCESS | 3978 | RSS: Main: 220106752 17:22:49 INFO - PROCESS | 3978 | 17:25:52 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36674/tests/dromaeo/cssquery-yui.html) 17:25:52 INFO - PROCESS | 3978 | RSS: Main: 221409280 17:25:52 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | Cycle 1(1): loaded http://localhost:36674/tests/dromaeo/cssquery-yui.html (next: http://localhost:36674/tests/dromaeo/cssquery-dojo.html) 17:28:55 INFO - PROCESS | 3978 | RSS: Main: 296054784 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | __start_tp_report 17:28:55 INFO - PROCESS | 3978 | _x_x_mozilla_page_load 17:28:55 INFO - PROCESS | 3978 | _x_x_mozilla_page_load_details 17:28:55 INFO - PROCESS | 3978 | |i|pagename|runs| 17:28:55 INFO - PROCESS | 3978 | |0;dojo.html;3180.825054621996;3214.5499630051813;3260.2827377976837;3267.5752152220207;3292.753043521735;5066.062778386001;5127.948770502047;5248.5276325130735;5269.235960785689;5332.093544097503;5168.328117344749;5226.660267082637;5246.501582349681;5264.263003179558;5298.761555729991;4673.649476289275;4703.553162449571;4751.0972915146185;4844.32179494871;4901.828436004741;4660;4835.202191638393;4883.658143929926;4896.338994235786;4896.853094407174;4686.156491831469;4773.71357718538;4780.115678599453;4806.279058141272;4833.250846118822;4765.189917713997;4765.21373973294;4770.570648641639;4777.617790576745;4812.903741925177;4717.43390793107;4759.476457589697;4780.4741478437345;4787.6648634595595;4794.304825800275;5039.2944987701385;5053.36832895888;5128.384593848725;5153.201253805666;5166.638335316492;5633.774649014034;5644.717764111778;5652.06740887753;5656.095024796013;5685.602007859451;5517.475839795253;5705.286839145107;5710.600257981943;5718.34239062509;5724.370319264877;5210.062188806013;5251.4485978972425;5261.1319132343115;5264;5293.602979776455;5630.8029218977135;5646.463585959327;5658.377578466366;5697.886042279214;5710.743016564182;5457.154141108134;5476.7535460904355;5506.752196151183;5530.778768849201;5534.640248383842;5524.889502209933;5563.276774019351;5617.887642247132;5620.409856965041;5624.71876406178;5522.806701765419;5523.8066667666435;5558.44415558441;5629.887402251932;5659.292588426447;5586.050371436784;5589.580781441408;5595.608307418523;5603.963266795656;5626.662400255997;4307.655387568987;4343.609075183185;4353.69524133314;4355.695101342939;4396.274614688605;3814.48504451901;3868.574456809749;3888.51393575803;3890.5525864525944;3897.162110146332;5085.1355269604255;5093.032323858455;5095.286659867622;5102.387713474407;5129.8204562840865;5569.359523654751;5570.58220633446;5574.693391863405;5576.553875689935;5623.831285061455;5079.87300317495;5092.872678183001;5100.821471248489;5166.121759300928;5194.039102766001;4801.759912004456;4808.422989241243;4826.469088400273;4827.444843842933;4867.902641947141;5850.882982340329;5865.120231965154;5870.295564532284;5870.706464676835;5871.178035075093;5491.697956612425;5520.1443776214755;5533.833984980457;5587.413321601173;5589.10574308125;5721.828345149652;5730.512906402836;5741.770329186786;5744.971275143597;5756.827295181151;5448.373437054789;5480.314960629921;5480.753366098455;5493.505584497414;5497.725113744376;5473.28847249855;5515.917261241165;5606.6636001840025;5637.182608521659;5646.209530665792;5477.835664930059;5482.150266708666;5483.4516548344845;5490.450954904478;5515.696636685021;5359.115745902039;5445.646033007842;5496.450354964471;5498.1752737089755;5550;5366.168243922199;5403.729813509231;5405.351357837085;5457.69982650958;5479.945200547943;5461.15352120422;5472.343318801769;5517.475839795213;5521.503064724194;5577.6653400796085;5337.412884582771;5366.463353664602;5398.055340315507;5405.756740946588;5412.350517937873 17:28:55 INFO - PROCESS | 3978 | |1;ext.html;534.2520471340121;535.7508758427331;541.1990254423454;557.8577462746999;559.3735016781205;27989.440211195764;28528.714712852867;38836.223275534474;39217.21565568687;39320.21359572807;42073.789631051804;42441.36337954933;42448;42645.14709705812;42673.786631066876;8607.268382187522;8779.692710755126;8811.603477843513;8813.779655508599;8820.558972051404;8606.526641034741;8730.956345218265;8735.388522803407;8735.432196907212;8739.257163141141;8759.036505984337;8781.253593444564;8811.823763524757;8815.382923195379;8819.162179592928;8706.129387061306;8755.255803256667;8759.912400876005;8767.912320876838;8775.341849361259;8615.396922215385;8726.912730872673;8733.475991440533;8740.650373985032;8744.562771861381;38922.61077389218;39336;39419;39428.21143577141;39437.211255774724;3105.580746599203;3156.8579413926427;3201.727853132463;3242.659520750311;3504.3516949364193;29567.260818479495;29741.851290743623;29970.400591988036;30660.540091898638;30874.845625771726;3936.4882565266616;4034.45534852797;4037.454943582608;4049.817758200888;4055.3511438169753;195306;195912;195982;196021.01989490105;196112;53131.73434132882;54560.454395456334;60594.394056058874;61620;61744;52762.472375275756;52804;52977;52979.47020529745;53005;15267.3893044277;15796.526104216891;16055.277512511731;16245.918770406071;16254.75617865733;12396.876031239752;12484.875151248552;12485.687857803627;12492.562760303346;12499.50001999928;19104.33134840274;19165.808341916403;19313.613727725366;19599;19602;7730.342920851678;7787.338076263468;7906.248906353887;7934.730443129071;7991.800204994805;837.5659794841224;872.7992561710842;929.7303781903307;972.2805124208177;1064.8988346107108;29483.975448347235;29545.11364659064;29717.702822971925;29868.402631947672;30632.84683576568;1081.3619964221148;1097.1716354152722;1099.4008265495165;1148.62095508482;1206.0773508266184;14480.855191448161;14809;14828.851711482963;16005.759913601305;16250.918745406198;238948;240616;240955;241523;243677;51065;51498.48501514937;52160.47839521556;52227;52417.47582524126;1330.5210124355417;1385.9099158554661;1386.7850483174923;1390.7913812927939;1396.3018490754623;29174.27064323324;29915.102546923627;30332.393352133276;30714.84642576773;30861.382772344878;42967.78516107525;43290.13419731651;43337.566624333354;43403.13193736171;43431;230115.24711881668;232451;232750;232801;233538;27363.589546156425;30582.847085764428;31092.22269443282;31877.840610797724;31902.68097318997;37301.81349093237;37340.813295933345;37543;37599.624003759614;38251;33351.49972750362;35423.291534169686;35439.468407973385;35935.64064359428;36728.63271367252;28026.518396022682;31638.367232654757;32518.349633006736;32574.51138232881;33969.49045764365;35503.82248088743;36341.45487817738;36388;36678.08304792295;36958.63041369552;30857.537136943414;31742.841285793424;32385.838070810438;32420.675793241764;32539.837300813346;24866.50266994686;25398.365040874127;25457.745422545537;25703.871480642476;25780.613290800276 17:28:55 INFO - PROCESS | 3978 | |2;jquery.html;373.46221441124777;375.24388357459725;375.66190428614254;377.14012052520263;379.60900272719107;9843.950780246107;10196;11384.203105782599;11846.526138954432;16132.83867161328;16999.065051422167;17123.31506739732;17526.211320490576;17638.559036024108;17658;4425.092855964535;5022.924656130161;6064.666443345614;6080.179175811275;6082.939170608303;6373.13962615048;6718.361755633231;6720.865582688343;6721.966390168042;6723.193216813989;6624.867502649944;6652.667366631673;6788.049673045753;6790.3549162829695;6794.626295553742;6422.2293324801085;6670.099536562599;6672.332766723337;6689.163854518185;6692.899606505906;6311.179546658951;6345.0482427636225;6368.5860419072615;6377.17096777416;6379.234491861006;21846.344609661737;22178.556428871492;22630.43423914399;22851.200207992806;22862.77137228623;2100.4433825036376;2138.283674968887;2237.295251995616;2472.5796614575565;2969.9902033308563;13307.534236301779;13747.793783093262;14156.362963666557;14412.351444185037;14436.206008669518;1919.4721451600783;1971.8323942464908;1981.8711783734154;2011.6580181369202;2063.9690404643943;66771;66911.66544167297;68323.3167668322;68619.9999999995;69035;14537.636559086108;15013.549593512213;15015.624609384853;15030;15037.548873533811;23494.177703780286;23539.882300588386;23558.764412356;23679.763202367754;23764.287071387887;7020.122484689414;7393.852122957511;7727.304542591081;7744.380449564022;7804.0635123785505;7111.217766045835;7117.572945623279;7159.105111861018;7175.533590316612;7506.924930750732;4178.289690752579;4348.630366418826;4488.438945131858;4531.546845315442;4545.409096817392;1828.506303298102;1852.2220667319757;1880.2009146112848;1891.3285783546644;1894.886306821595;469.5023275328163;867.7049803066988;917.3532659475054;999.7200783780553;1000.2398177385094;9670.854937175947;10786.191035672357;11025.889741102646;11271.661850144344;11530.308181509135;468.94607120181615;470.1443373060996;475.7716296177854;488.836239859651;490.6687985609699;5065.569426598707;6040.365761595057;6095.177151084636;6216.912040392913;6331;504024;526154;528305;531523;541279;75802.62098689581;78029;78222;78654.606726966;79262.6036869812;1135.250734515216;1160.124106299755;1170.1925671286615;1179.7699448607611;1187.1689817128045;15416;15489.922550387177;15497.380104795682;15525.767113493532;15856;33834.49248261327;34611.653883460844;34737.82631086828;35066.649333506335;35409.29181416306;48215.5178448211;48328.758356207996;48743;48817.36235057664;48824.75587622039;7350.595717235389;7389.926100738924;7479.139898911695;7607.923920760722;7653.617319133909;10755.408452535186;11058.612948547085;11465.713357166138;11486.82769758471;11846.58536951237;9786.706398808046;10119.645812396531;10145.289829712145;10249.948750256499;10329.483525823829;8203.343732501266;9853.802923941625;9921.900780992097;9984.151347135285;10011.449370284414;9663.9033609663;9958.601655933682;10055.346402483816;10197.184225261813;10280.280380373302;6923.792286231421;7548;7556.433267505069;7558.206388329366;7584.12782529994;9109.407888487227;9974.3017988743;10361.4301213434;10388.844167337345;10587.311824731369 17:28:55 INFO - PROCESS | 3978 | |3;mootools.html;1335.6208791756858;1459.5986103821447;1463.9414423423063;1645.8683305335567;1803.27868852459;7210.639468026598;7243.492955493111;7361.043064401633;7377.631118444083;7380.114386273642;7766.262205090507;7957.323627491655;8010;8020;8023.598820059003;2046.4781480722395;2095.8532902696816;2096.014873009683;2342.8360014798973;2368.2658375903525;2312.7571604981404;2365.787079162875;2366.065404165354;2366.6213405855065;2367.0413482539598;2304.9423764405856;2318.5710643530915;2337.614293641556;2367.3134790910617;2368.9763102369016;2349.365671268748;2354.7292061412986;2364.326167042393;2367.9526409471887;2391.4021494626345;2356.7643235676464;2362.2795047510504;2382.702162229721;2388.617821148608;2399.700037495313;7757.069151701832;7796.025496812898;7797.142314345418;7802.063752349754;7802.687892484294;4890.339804126433;5074.416442109168;5075.873103172414;5077.974610126963;5083.262926875619;3169.6513383527795;3182.984085079583;3231.7737758356925;3299.868005279786;3302.6036875575087;1030.654730665228;1054.3463052907246;1078.229066217658;1088.0207812968392;1113.4711012269188;10986.176036797273;11091.611793587266;11142.052925501343;11152.163587730953;11158.442077896072;4308.46144231971;4438.556144385536;4478.373027776114;4482.439695038121;4486.910261794811;9474.147326740627;9525.714228573015;9527.047295270417;9539.046095390406;9579.281553883488;4973.925391119136;5012.398512178489;5032.043911656773;5043.193089105725;5046.066477701637;4581.404417425713;4582.404287442611;4582.495925448198;4589.35748995141;4597.632189424838;3565.322588708137;3751.2122454284904;3756;3796.145867179918;3849.2493963676816;1251.1054595963747;1260.4706023470164;1270.28863836252;1272.8918041966351;1281.6667666406802;1298.8116723075102;1304.8368953880765;1338.899582531314;1365.7883028130655;1365.7951307303983;7461.888071678929;7513.248675132443;7513.737019204411;7523.8495230095095;7528.322450979329;1117.7038084907506;1131.1290306463977;1135.517405102828;1145.7422080032093;1150.4937827355936;5925.081612350093;6049.909251361233;6056.212692350055;6056.454919057306;6057.757689692363;9188.356815023018;9490.050994900455;9591.136797688241;9595.90404095964;9669.516524173903;9578.377405468622;9598.232141428669;9601.135897769234;9613.807723845484;9617.807643847224;7292.234315396913;7474.289942455458;7477.85044299111;7563.168051514329;7570.848583028419;7133.2153463117975;7213.20654727969;7230.276972302728;7246.782596522113;7258;8528.872066918877;8555.443896146731;8600.741977740678;8743.825123497367;8744.169303916118;8791.252743516872;8809.163129502687;8819.779505512413;8966.955165224132;8967.730968070968;6800.727970881109;6819.522633415613;6876.587404755731;6881.380675739208;6884.827879303058;6752.716983773067;6911.343422374866;6919;7043.964780176067;7595.924040759522;6788.389044985975;6828.487863410363;6879.312068793281;6935.133108361455;6977.197622273504;6545.345465453416;6591.670416479253;6606;6686.732530698718;6699.899501507579;6751.459883209233;6824.692888819915;6833.384995350442;6834.658267086526;6842.0763196969765;6372.968135159294;6425.1968503937005;6470.805875823733;6520.934790652223;6529.216494020748;6523.64119973406;6581.3418658133805;6586.308437613981;6587.934120658732;6596.142501474777 17:28:55 INFO - PROCESS | 3978 | |4;prototype.html;337.2210194450819;343.82293119043715;344.06071425009713;344.7638367718113;350.9771864828788;5752.28096487939;5779.682117483537;5853.7951171709;5855.795047173355;5863.648181109136;5501.889962200764;5620.46605572471;5634.183043458706;5758.107493338529;5796.82609521715;4492.550744925514;4506.436695413082;4521.683482156251;4537.069900670354;4549.090181963604;4308.676849236304;4515.074409746011;4529.456465224162;4529.592336689697;4537.047220083787;4382.233109205877;4475.28395456727;4481.551844815525;4485.753283569403;4502.077074199781;4435.379046933432;4445.8221671133115;4459;4460.107978404332;4465.508794032654;3924.666403355718;3930.803459827026;3931.941020884689;3934.881953541398;3946.210757848413;5407.648502847303;5470.699111548864;5487.42382049883;5493.587980901449;5505.03661859177;5179.430262671103;5216.478352164791;5218.217267409881;5222.556082732972;5223.164293712987;6117.755289788403;6120.051392034242;6126.571140020201;6128.57100003;6130.356312587159;4381.058072514425;4388.1004394099455;4391.077873646538;4393.494748103977;4399.934000989988;6252.906206406908;6303.653299068549;6381.712822922979;6396.168498095218;6409.391107844794;4485.506594274627;4485.923378389229;4491.146682130385;4492.415985921874;4495.190865644216;4544.18204723153;4553.408056952575;4555.157295900269;4555.906582420195;4558.407407037064;5192.169252919514;5194.428612852583;5195.428502864682;5197.610179236573;5197.7401129943355;6095.329513753483;6156.138140660311;6200.968995154995;6204.81385558425;6214.564980451415;1604.0856711674235;1604.8475394837471;1620.8703303735672;1620.9837901620833;1622.059205660714;1091.3124731419155;1098.3080659184823;1106.2975010868156;1120.3389999900098;1122.421952694363;5766.163906233573;5802.767889284466;5819.73811178498;5825.563082768809;5825.737841797045;6296.779612713624;6318.557700960889;6340.048992651139;6346.8413289667205;6351.460125889259;5604.747786349624;5647.068233741469;5744.454276843693;5762.798302059407;5770.711464426762;3378.7803792753393;3412.436947903568;3417.401954657975;3425.143714071482;3428.160100775276;6589.6375699336995;6614.7023383947835;6634.966825165843;6662.433693136138;6663.633500157538;6405.231372235362;6550.0829883816305;6565.737370505126;6572.671366431659;6576.671166441754;6638.402543770987;6638.502112341497;6640.9667951660895;6644;6681.766138185238;6385.265694445198;6388.584741991755;6410.9038364425505;6412.519061070345;6428.517861160525;6165.630062196283;6336.493080553452;6336.58812177207;6340.873182536416;6354.23749150105;6548.541602087808;6550.279469258473;6551.705173267119;6557.147570815763;6565.540412171103;4492.303692927601;4492.955070449384;4533.320001999727;4535.160995215896;4540.273556230987;6116.3883611638485;6270.686465676789;6274.874502509833;6298.307186209422;6301.180846489927;6084.6349219047;6121.724522396592;6129.111278864629;6138.324784273816;6139.600925939978;6103.328633850184;6106.267247930276;6112.541559383153;6120.908186377297;6124.081387791867;5848.619839710405;5974.880502389841;5982;5985.700714964148;5989.7304621293015;6149.292831324455;6153.353897840662;6163.660998644938;6195.907061393992;6208.968955155376;6031.4270144336215;6042.848928776816;6043.184170137151;6049.941260279522;6054.515638748978 17:28:55 INFO - PROCESS | 3978 | |5;yui.html;800.179367728756;808.2765924497575;813.6818354266088;825.5830805443251;826.3513142183388;12394.504219831208;12394.504219831208;12425.689357766061;12466.626001219978;12506.124571280014;10816.080633146172;11763.470643821027;11795.823062654066;11806.704832379195;11816.054715622751;677.9152605924272;830.6552780596045;842.0695131879277;843.3169133002257;843.9409241353108;838.7986883148061;845.2350622686479;846.255295340103;846.6232526525698;846.6782622603403;717.6268340462956;878.3456325037856;878.6573236437795;883.8541640629288;884.5046773806657;860.1355637584188;870.8606622940363;871.0984131424009;871.538084815049;872.0799556467924;641.6695401867995;641.9743210271583;649.89276769333;652.4519403700914;652.4910569755551;11897.94051029748;12289.69275768104;12296.323702196376;12317.322547259897;12334.259944403364;12834.679133021657;13166.210027398387;13295.933520332337;13298.135621184592;13367.064305498521;9319.487428191447;9369.250459963187;9590.568424420917;9719.757006074835;10527.368357898475;3277.7899583424746;3409.880654177092;3438.570178727659;3486.1981744198724;3494.8427320770625;45745.77127114376;45754.31368529475;45843.31235031477;45972.77013614944;47237.527624723654;10093.495325233709;10112.443815590213;10155.746106347253;10156.847647285149;10295.897041029493;18220.36228731988;18336.083195840154;18350.357737479124;18612.906935465508;18622.348217812312;7432.62836858155;7567.940488331638;7578.355839753683;7705.614719264015;7724.995750552393;4257.957420425818;4288.2495563276925;4338.739675619473;4339.1972485090355;4352.651787856964;2973.8215707057648;2999.925001874971;3013.8794448222266;3017;3025.803322784056;524.4833838668908;553.590343146069;556.5436342199439;556.7772890843695;570;658.9308122647149;701.5229643842237;706.2161001288565;717.6483523073761;730.3098571849657;8596.140385961355;8845.69040083594;9289;9470.14768670823;9654.420734755937;578.095280885413;589.5872888977733;626.8213559135625;632.7943418389042;634.2294112653057;4061.2080644274083;4138.5654506276405;4148.8133034012935;4202.432671589358;4262.70161088727;51349;52177.2173417399;52389;52410.21384679233;52453.73773131186;48499.272510912364;48772.26841597379;48924.510754892704;49588.50411495911;49730.25404618934;38599.807000964815;39539.604603953594;39786.60213397887;41303.38044929328;41465;8782.473051616924;8936.597853096757;8975.237104846161;9035.232005279624;9130.49782261982;33646;33829.66170338364;33907;34193.316133676686;34749.13127171841;41038.76883693494;41218;41609;42284.15431691411;42306;11308.830367544659;11400.201985860911;11747.471363788822;12104.939475302566;12129.090318226345;12187.51249949992;12399.442025108712;12526.624201273977;12799.168054076456;12809.487620495076;11309.151813614177;11621.941890290494;11847.348395837967;11901.583444579399;12045.819312710491;11244.437778111225;11304.547818087512;11372.147088968195;11697.23967942081;11778;11387.316760994367;11563.768724625628;11681.88318116842;11938.403079846146;12368.876311237133;9015.323850711355;9077.137671921157;9421.246300295823;10029.69910902674;10060.899391006289;9323.440593564408;9375.156235938799;9956.352837065568;10140.847887281549;10454.947725261325 17:28:55 INFO - PROCESS | 3978 | __end_tp_report 17:28:55 INFO - PROCESS | 3978 | __start_cc_report 17:28:55 INFO - PROCESS | 3978 | _x_x_mozilla_cycle_collect,929 17:28:55 INFO - PROCESS | 3978 | __end_cc_report 17:28:55 INFO - PROCESS | 3978 | __startTimestamp1454808535686__endTimestamp 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | ------- Summary: start ------- 17:28:55 INFO - PROCESS | 3978 | Number of tests: 6 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | [#0] dojo.html Cycles:165 Average:5200.00 Median:5405.76 stddev:556.65 (10.3%) stddev-sans-first:535.34 17:28:55 INFO - PROCESS | 3978 | Values: 3180.8 3214.5 3260.3 3267.6 3292.8 5066.1 5127.9 5248.5 5269.2 5332.1 5168.3 5226.7 5246.5 5264.3 5298.8 4673.6 4703.6 4751.1 4844.3 4901.8 4660.0 4835.2 4883.7 4896.3 4896.9 4686.2 4773.7 4780.1 4806.3 4833.3 4765.2 4765.2 4770.6 4777.6 4812.9 4717.4 4759.5 4780.5 4787.7 4794.3 5039.3 5053.4 5128.4 5153.2 5166.6 5633.8 5644.7 5652.1 5656.1 5685.6 5517.5 5705.3 5710.6 5718.3 5724.4 5210.1 5251.4 5261.1 5264.0 5293.6 5630.8 5646.5 5658.4 5697.9 5710.7 5457.2 5476.8 5506.8 5530.8 5534.6 5524.9 5563.3 5617.9 5620.4 5624.7 5522.8 5523.8 5558.4 5629.9 5659.3 5586.1 5589.6 5595.6 5604.0 5626.7 4307.7 4343.6 4353.7 4355.7 4396.3 3814.5 3868.6 3888.5 3890.6 3897.2 5085.1 5093.0 5095.3 5102.4 5129.8 5569.4 5570.6 5574.7 5576.6 5623.8 5079.9 5092.9 5100.8 5166.1 5194.0 4801.8 4808.4 4826.5 4827.4 4867.9 5850.9 5865.1 5870.3 5870.7 5871.2 5491.7 5520.1 5533.8 5587.4 5589.1 5721.8 5730.5 5741.8 5745.0 5756.8 5448.4 5480.3 5480.8 5493.5 5497.7 5473.3 5515.9 5606.7 5637.2 5646.2 5477.8 5482.2 5483.5 5490.5 5515.7 5359.1 5445.6 5496.5 5498.2 5550.0 5366.2 5403.7 5405.4 5457.7 5479.9 5461.2 5472.3 5517.5 5521.5 5577.7 5337.4 5366.5 5398.1 5405.8 5412.4 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | [#1] ext.html Cycles:180 Average:39929.90 Median:35471.65 stddev:57963.66 (163.4%) stddev-sans-first:58050.78 17:28:55 INFO - PROCESS | 3978 | Values: 534.3 535.8 541.2 557.9 559.4 27989.4 28528.7 38836.2 39217.2 39320.2 42073.8 42441.4 42448.0 42645.1 42673.8 8607.3 8779.7 8811.6 8813.8 8820.6 8606.5 8731.0 8735.4 8735.4 8739.3 8759.0 8781.3 8811.8 8815.4 8819.2 8706.1 8755.3 8759.9 8767.9 8775.3 8615.4 8726.9 8733.5 8740.7 8744.6 38922.6 39336.0 39419.0 39428.2 39437.2 3105.6 3156.9 3201.7 3242.7 3504.4 29567.3 29741.9 29970.4 30660.5 30874.8 3936.5 4034.5 4037.5 4049.8 4055.4 195306.0 195912.0 195982.0 196021.0 196112.0 53131.7 54560.5 60594.4 61620.0 61744.0 52762.5 52804.0 52977.0 52979.5 53005.0 15267.4 15796.5 16055.3 16245.9 16254.8 12396.9 12484.9 12485.7 12492.6 12499.5 19104.3 19165.8 19313.6 19599.0 19602.0 7730.3 7787.3 7906.2 7934.7 7991.8 837.6 872.8 929.7 972.3 1064.9 29484.0 29545.1 29717.7 29868.4 30632.8 1081.4 1097.2 1099.4 1148.6 1206.1 14480.9 14809.0 14828.9 16005.8 16250.9 238948.0 240616.0 240955.0 241523.0 243677.0 51065.0 51498.5 52160.5 52227.0 52417.5 1330.5 1385.9 1386.8 1390.8 1396.3 29174.3 29915.1 30332.4 30714.8 30861.4 42967.8 43290.1 43337.6 43403.1 43431.0 230115.2 232451.0 232750.0 232801.0 233538.0 27363.6 30582.8 31092.2 31877.8 31902.7 37301.8 37340.8 37543.0 37599.6 38251.0 33351.5 35423.3 35439.5 35935.6 36728.6 28026.5 31638.4 32518.3 32574.5 33969.5 35503.8 36341.5 36388.0 36678.1 36958.6 30857.5 31742.8 32385.8 32420.7 32539.8 24866.5 25398.4 25457.7 25703.9 25780.6 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | [#2] jquery.html Cycles:180 Average:28289.80 Median:2507.18 stddev:86176.77 (3437.2%) stddev-sans-first:86393.02 17:28:55 INFO - PROCESS | 3978 | Values: 373.5 375.2 375.7 377.1 379.6 9844.0 10196.0 11384.2 11846.5 16132.8 16999.1 17123.3 17526.2 17638.6 17658.0 4425.1 5022.9 6064.7 6080.2 6082.9 6373.1 6718.4 6720.9 6722.0 6723.2 6624.9 6652.7 6788.0 6790.4 6794.6 6422.2 6670.1 6672.3 6689.2 6692.9 6311.2 6345.0 6368.6 6377.2 6379.2 21846.3 22178.6 22630.4 22851.2 22862.8 2100.4 2138.3 2237.3 2472.6 2970.0 13307.5 13747.8 14156.4 14412.4 14436.2 1919.5 1971.8 1981.9 2011.7 2064.0 66771.0 66911.7 68323.3 68620.0 69035.0 14537.6 15013.5 15015.6 15030.0 15037.5 23494.2 23539.9 23558.8 23679.8 23764.3 7020.1 7393.9 7727.3 7744.4 7804.1 7111.2 7117.6 7159.1 7175.5 7506.9 4178.3 4348.6 4488.4 4531.5 4545.4 1828.5 1852.2 1880.2 1891.3 1894.9 469.5 867.7 917.4 999.7 1000.2 9670.9 10786.2 11025.9 11271.7 11530.3 468.9 470.1 475.8 488.8 490.7 5065.6 6040.4 6095.2 6216.9 6331.0 504024.0 526154.0 528305.0 531523.0 541279.0 75802.6 78029.0 78222.0 78654.6 79262.6 1135.3 1160.1 1170.2 1179.8 1187.2 15416.0 15489.9 15497.4 15525.8 15856.0 33834.5 34611.7 34737.8 35066.6 35409.3 48215.5 48328.8 48743.0 48817.4 48824.8 7350.6 7389.9 7479.1 7607.9 7653.6 10755.4 11058.6 11465.7 11486.8 11846.6 9786.7 10119.6 10145.3 10249.9 10329.5 8203.3 9853.8 9921.9 9984.2 10011.4 9663.9 9958.6 10055.3 10197.2 10280.3 6923.8 7548.0 7556.4 7558.2 7584.1 9109.4 9974.3 10361.4 10388.8 10587.3 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | [#3] mootools.html Cycles:180 Average:5551.41 Median:6399.08 stddev:2843.28 (44.4%) stddev-sans-first:2833.60 17:28:55 INFO - PROCESS | 3978 | Values: 1335.6 1459.6 1463.9 1645.9 1803.3 7210.6 7243.5 7361.0 7377.6 7380.1 7766.3 7957.3 8010.0 8020.0 8023.6 2046.5 2095.9 2096.0 2342.8 2368.3 2312.8 2365.8 2366.1 2366.6 2367.0 2304.9 2318.6 2337.6 2367.3 2369.0 2349.4 2354.7 2364.3 2368.0 2391.4 2356.8 2362.3 2382.7 2388.6 2399.7 7757.1 7796.0 7797.1 7802.1 7802.7 4890.3 5074.4 5075.9 5078.0 5083.3 3169.7 3183.0 3231.8 3299.9 3302.6 1030.7 1054.3 1078.2 1088.0 1113.5 10986.2 11091.6 11142.1 11152.2 11158.4 4308.5 4438.6 4478.4 4482.4 4486.9 9474.1 9525.7 9527.0 9539.0 9579.3 4973.9 5012.4 5032.0 5043.2 5046.1 4581.4 4582.4 4582.5 4589.4 4597.6 3565.3 3751.2 3756.0 3796.1 3849.2 1251.1 1260.5 1270.3 1272.9 1281.7 1298.8 1304.8 1338.9 1365.8 1365.8 7461.9 7513.2 7513.7 7523.8 7528.3 1117.7 1131.1 1135.5 1145.7 1150.5 5925.1 6049.9 6056.2 6056.5 6057.8 9188.4 9490.1 9591.1 9595.9 9669.5 9578.4 9598.2 9601.1 9613.8 9617.8 7292.2 7474.3 7477.9 7563.2 7570.8 7133.2 7213.2 7230.3 7246.8 7258.0 8528.9 8555.4 8600.7 8743.8 8744.2 8791.3 8809.2 8819.8 8967.0 8967.7 6800.7 6819.5 6876.6 6881.4 6884.8 6752.7 6911.3 6919.0 7044.0 7595.9 6788.4 6828.5 6879.3 6935.1 6977.2 6545.3 6591.7 6606.0 6686.7 6699.9 6751.5 6824.7 6833.4 6834.7 6842.1 6373.0 6425.2 6470.8 6520.9 6529.2 6523.6 6581.3 6586.3 6587.9 6596.1 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | [#4] prototype.html Cycles:180 Average:5163.64 Median:5775.20 stddev:1525.16 (26.4%) stddev-sans-first:1485.79 17:28:55 INFO - PROCESS | 3978 | Values: 337.2 343.8 344.1 344.8 351.0 5752.3 5779.7 5853.8 5855.8 5863.6 5501.9 5620.5 5634.2 5758.1 5796.8 4492.6 4506.4 4521.7 4537.1 4549.1 4308.7 4515.1 4529.5 4529.6 4537.0 4382.2 4475.3 4481.6 4485.8 4502.1 4435.4 4445.8 4459.0 4460.1 4465.5 3924.7 3930.8 3931.9 3934.9 3946.2 5407.6 5470.7 5487.4 5493.6 5505.0 5179.4 5216.5 5218.2 5222.6 5223.2 6117.8 6120.1 6126.6 6128.6 6130.4 4381.1 4388.1 4391.1 4393.5 4399.9 6252.9 6303.7 6381.7 6396.2 6409.4 4485.5 4485.9 4491.1 4492.4 4495.2 4544.2 4553.4 4555.2 4555.9 4558.4 5192.2 5194.4 5195.4 5197.6 5197.7 6095.3 6156.1 6201.0 6204.8 6214.6 1604.1 1604.8 1620.9 1621.0 1622.1 1091.3 1098.3 1106.3 1120.3 1122.4 5766.2 5802.8 5819.7 5825.6 5825.7 6296.8 6318.6 6340.0 6346.8 6351.5 5604.7 5647.1 5744.5 5762.8 5770.7 3378.8 3412.4 3417.4 3425.1 3428.2 6589.6 6614.7 6635.0 6662.4 6663.6 6405.2 6550.1 6565.7 6572.7 6576.7 6638.4 6638.5 6641.0 6644.0 6681.8 6385.3 6388.6 6410.9 6412.5 6428.5 6165.6 6336.5 6336.6 6340.9 6354.2 6548.5 6550.3 6551.7 6557.1 6565.5 4492.3 4493.0 4533.3 4535.2 4540.3 6116.4 6270.7 6274.9 6298.3 6301.2 6084.6 6121.7 6129.1 6138.3 6139.6 6103.3 6106.3 6112.5 6120.9 6124.1 5848.6 5974.9 5982.0 5985.7 5989.7 6149.3 6153.4 6163.7 6195.9 6209.0 6031.4 6042.8 6043.2 6049.9 6054.5 17:28:55 INFO - PROCESS | 3978 | 17:28:55 INFO - PROCESS | 3978 | [#5] yui.html Cycles:180 Average:13250.96 Median:4275.48 stddev:14737.38 (344.7%) stddev-sans-first:14749.06 17:28:55 INFO - PROCESS | 3978 | Values: 800.2 808.3 813.7 825.6 826.4 12394.5 12394.5 12425.7 12466.6 12506.1 10816.1 11763.5 11795.8 11806.7 11816.1 677.9 830.7 842.1 843.3 843.9 838.8 845.2 846.3 846.6 846.7 717.6 878.3 878.7 883.9 884.5 860.1 870.9 871.1 871.5 872.1 641.7 642.0 649.9 652.5 652.5 11897.9 12289.7 12296.3 12317.3 12334.3 12834.7 13166.2 13295.9 13298.1 13367.1 9319.5 9369.3 9590.6 9719.8 10527.4 3277.8 3409.9 3438.6 3486.2 3494.8 45745.8 45754.3 45843.3 45972.8 47237.5 10093.5 10112.4 10155.7 10156.8 10295.9 18220.4 18336.1 18350.4 18612.9 18622.3 7432.6 7567.9 7578.4 7705.6 7725.0 4258.0 4288.2 4338.7 4339.2 4352.7 2973.8 2999.9 3013.9 3017.0 3025.8 524.5 553.6 556.5 556.8 570.0 658.9 701.5 706.2 717.6 730.3 8596.1 8845.7 9289.0 9470.1 9654.4 578.1 589.6 626.8 632.8 634.2 4061.2 4138.6 4148.8 4202.4 4262.7 51349.0 52177.2 52389.0 52410.2 52453.7 48499.3 48772.3 48924.5 49588.5 49730.3 38599.8 39539.6 39786.6 41303.4 41465.0 8782.5 8936.6 8975.2 9035.2 9130.5 33646.0 33829.7 33907.0 34193.3 34749.1 41038.8 41218.0 41609.0 42284.2 42306.0 11308.8 11400.2 11747.5 12104.9 12129.1 12187.5 12399.4 12526.6 12799.2 12809.5 11309.2 11621.9 11847.3 11901.6 12045.8 11244.4 11304.5 11372.1 11697.2 11778.0 11387.3 11563.8 11681.9 11938.4 12368.9 9015.3 9077.1 9421.2 10029.7 10060.9 9323.4 9375.2 9956.4 10140.8 10454.9 17:28:55 INFO - PROCESS | 3978 | -------- Summary: end -------- 17:28:55 INFO - PROCESS | 3978 | 17:28:56 INFO - TEST-INFO | 3978: exit 0 17:28:56 INFO - TEST-OK | dromaeo_css | took 1112702ms 17:28:56 INFO - TEST-START | kraken 17:28:56 INFO - operating with platform_type : linux_ 17:28:56 INFO - Initialising browser for kraken test... 17:28:56 INFO - TEST-INFO | started process 4162 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmperf8bG/profile http://localhost:36674/getInfo.html) 17:29:00 INFO - PROCESS | 4162 | __metrics Screen width/height:1600/1200 17:29:00 INFO - PROCESS | 4162 | colorDepth:24 17:29:00 INFO - PROCESS | 4162 | Browser inner width/height: 1024/697 17:29:00 INFO - PROCESS | 4162 | __metrics 17:29:00 INFO - PROCESS | 4162 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:29:01 INFO - TEST-INFO | 4162: exit 0 17:29:01 INFO - Browser initialized. 17:29:01 INFO - Running cycle 1/1 for kraken test... 17:29:01 INFO - TEST-INFO | started process 4249 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmperf8bG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:29:13 INFO - PROCESS | 4249 | RSS: Main: 151609344 17:29:13 INFO - PROCESS | 4249 | 17:29:15 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36674/tests/kraken/driver.html?testName=audio-beat-detection) 17:29:16 INFO - PROCESS | 4249 | RSS: Main: 194195456 17:29:16 INFO - PROCESS | 4249 | 17:29:18 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36674/tests/kraken/driver.html?testName=audio-dft) 17:29:19 INFO - PROCESS | 4249 | RSS: Main: 183554048 17:29:19 INFO - PROCESS | 4249 | 17:29:22 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36674/tests/kraken/driver.html?testName=audio-fft) 17:29:23 INFO - PROCESS | 4249 | RSS: Main: 167038976 17:29:23 INFO - PROCESS | 4249 | 17:29:25 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36674/tests/kraken/driver.html?testName=audio-oscillator) 17:29:25 INFO - PROCESS | 4249 | RSS: Main: 169525248 17:29:25 INFO - PROCESS | 4249 | 17:29:27 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:29:28 INFO - PROCESS | 4249 | RSS: Main: 170971136 17:29:28 INFO - PROCESS | 4249 | 17:29:31 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36674/tests/kraken/driver.html?testName=imaging-darkroom) 17:29:32 INFO - PROCESS | 4249 | RSS: Main: 169734144 17:29:32 INFO - PROCESS | 4249 | 17:29:35 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36674/tests/kraken/driver.html?testName=imaging-desaturate) 17:29:36 INFO - PROCESS | 4249 | RSS: Main: 172527616 17:29:36 INFO - PROCESS | 4249 | 17:29:38 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36674/tests/kraken/driver.html?testName=json-parse-financial) 17:29:39 INFO - PROCESS | 4249 | RSS: Main: 172269568 17:29:39 INFO - PROCESS | 4249 | 17:29:40 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:29:41 INFO - PROCESS | 4249 | RSS: Main: 183328768 17:29:41 INFO - PROCESS | 4249 | 17:29:43 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:29:43 INFO - PROCESS | 4249 | RSS: Main: 180465664 17:29:43 INFO - PROCESS | 4249 | 17:29:46 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:29:46 INFO - PROCESS | 4249 | RSS: Main: 189476864 17:29:46 INFO - PROCESS | 4249 | 17:29:49 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:29:49 INFO - PROCESS | 4249 | RSS: Main: 196571136 17:29:49 INFO - PROCESS | 4249 | 17:29:52 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:29:52 INFO - PROCESS | 4249 | RSS: Main: 197603328 17:29:52 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | Cycle 1(1): loaded http://localhost:36674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36674/tests/kraken/driver.html?testName=ai-astar) 17:29:54 INFO - PROCESS | 4249 | RSS: Main: 256790528 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | __start_tp_report 17:29:54 INFO - PROCESS | 4249 | _x_x_mozilla_page_load 17:29:54 INFO - PROCESS | 4249 | _x_x_mozilla_page_load_details 17:29:54 INFO - PROCESS | 4249 | |i|pagename|runs| 17:29:54 INFO - PROCESS | 4249 | |0;ai-astar;111;115;109;112;114;112;102;111;110;110 17:29:54 INFO - PROCESS | 4249 | |1;audio-beat-detection;160;151;154;170;129;160;146;129;171;127 17:29:54 INFO - PROCESS | 4249 | |2;audio-dft;162;162;161;162;160;160;162;162;163;162 17:29:54 INFO - PROCESS | 4249 | |3;audio-fft;75;75;98;100;72;72;72;102;100;72 17:29:54 INFO - PROCESS | 4249 | |4;audio-oscillator;95;96;141;95;96;96;142;96;96;143 17:29:54 INFO - PROCESS | 4249 | |5;imaging-gaussian-blur;118;115;115;115;115;115;114;115;114;115 17:29:54 INFO - PROCESS | 4249 | |6;imaging-darkroom;146;146;146;146;147;146;147;146;147;146 17:29:54 INFO - PROCESS | 4249 | |7;imaging-desaturate;96;96;95;95;95;96;96;96;96;96 17:29:54 INFO - PROCESS | 4249 | |8;json-parse-financial;59;60;58;58;63;57;57;66;55;56 17:29:54 INFO - PROCESS | 4249 | |9;json-stringify-tinderbox;68;68;67;68;69;68;68;67;67;67 17:29:54 INFO - PROCESS | 4249 | |10;stanford-crypto-aes;86;92;87;86;86;86;85;87;84;92 17:29:54 INFO - PROCESS | 4249 | |11;stanford-crypto-ccm;115;115;115;116;121;118;125;122;116;122 17:29:54 INFO - PROCESS | 4249 | |12;stanford-crypto-pbkdf2;153;139;149;155;154;144;158;164;163;149 17:29:54 INFO - PROCESS | 4249 | |13;stanford-crypto-sha256-iterative;71;70;67;70;70;68;68;69;69;67 17:29:54 INFO - PROCESS | 4249 | __end_tp_report 17:29:54 INFO - PROCESS | 4249 | __start_cc_report 17:29:54 INFO - PROCESS | 4249 | _x_x_mozilla_cycle_collect,992 17:29:54 INFO - PROCESS | 4249 | __end_cc_report 17:29:54 INFO - PROCESS | 4249 | __startTimestamp1454808594809__endTimestamp 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | ------- Summary: start ------- 17:29:54 INFO - PROCESS | 4249 | Number of tests: 14 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:3.53 (3.2%) stddev-sans-first:3.75 17:29:54 INFO - PROCESS | 4249 | Values: 111.0 115.0 109.0 112.0 114.0 112.0 102.0 111.0 110.0 110.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:157.00 stddev:16.61 (10.6%) stddev-sans-first:17.20 17:29:54 INFO - PROCESS | 4249 | Values: 160.0 151.0 154.0 170.0 129.0 160.0 146.0 129.0 171.0 127.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.01 17:29:54 INFO - PROCESS | 4249 | Values: 162.0 162.0 161.0 162.0 160.0 160.0 162.0 162.0 163.0 162.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#3] audio-fft Cycles:10 Average:83.80 Median:72.00 stddev:14.02 (19.5%) stddev-sans-first:14.51 17:29:54 INFO - PROCESS | 4249 | Values: 75.0 75.0 98.0 100.0 72.0 72.0 72.0 102.0 100.0 72.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:96.00 stddev:22.37 (23.3%) stddev-sans-first:23.09 17:29:54 INFO - PROCESS | 4249 | Values: 95.0 96.0 141.0 95.0 96.0 96.0 142.0 96.0 96.0 143.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.10 (1.0%) stddev-sans-first:0.44 17:29:54 INFO - PROCESS | 4249 | Values: 118.0 115.0 115.0 115.0 115.0 115.0 114.0 115.0 114.0 115.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 17:29:54 INFO - PROCESS | 4249 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:29:54 INFO - PROCESS | 4249 | Values: 96.0 96.0 95.0 95.0 95.0 96.0 96.0 96.0 96.0 96.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:58.50 stddev:3.35 (5.7%) stddev-sans-first:3.55 17:29:54 INFO - PROCESS | 4249 | Values: 59.0 60.0 58.0 58.0 63.0 57.0 57.0 66.0 55.0 56.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:29:54 INFO - PROCESS | 4249 | Values: 68.0 68.0 67.0 68.0 69.0 68.0 68.0 67.0 67.0 67.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.73 (3.2%) stddev-sans-first:2.86 17:29:54 INFO - PROCESS | 4249 | Values: 86.0 92.0 87.0 86.0 86.0 86.0 85.0 87.0 84.0 92.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#11] stanford-crypto-ccm Cycles:10 Average:118.50 Median:119.50 stddev:3.69 (3.1%) stddev-sans-first:3.69 17:29:54 INFO - PROCESS | 4249 | Values: 115.0 115.0 115.0 116.0 121.0 118.0 125.0 122.0 116.0 122.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:154.50 stddev:7.89 (5.1%) stddev-sans-first:8.36 17:29:54 INFO - PROCESS | 4249 | Values: 153.0 139.0 149.0 155.0 154.0 144.0 158.0 164.0 163.0 149.0 17:29:54 INFO - PROCESS | 4249 | 17:29:54 INFO - PROCESS | 4249 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.50 stddev:1.37 (2.0%) stddev-sans-first:1.22 17:29:54 INFO - PROCESS | 4249 | Values: 71.0 70.0 67.0 70.0 70.0 68.0 68.0 69.0 69.0 67.0 17:29:54 INFO - PROCESS | 4249 | -------- Summary: end -------- 17:29:54 INFO - PROCESS | 4249 | 17:29:55 INFO - TEST-INFO | 4249: exit 0 17:29:55 INFO - TEST-OK | kraken | took 59347ms 17:29:55 INFO - SUITE-END | took 1172s 17:29:55 INFO - Completed test suite (00:19:32) 17:29:55 INFO - Working with test: dromaeo_css 17:29:55 INFO - Generating results file: dromaeo_css 17:29:55 INFO - Working with test: kraken 17:29:55 INFO - Generating results file: kraken 17:29:55 INFO - javascript benchmark 17:29:55 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:29:56 INFO - process_Request line: dromaeo_css 6870.49 graph.html#tests=[[72,64,35]] 17:29:56 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:29:56 INFO - process_Request line: kraken 1526.30 graph.html#tests=[[232,64,35]] 17:29:56 INFO - RETURN: dromaeo_css: 6870.49 17:29:56 INFO - RETURN: kraken: 1526.30 17:29:56 INFO - javascript benchmark 17:29:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3180.825054621996, 3214.5499630051813, 3260.2827377976837, 3267.5752152220207, 3292.753043521735, 5066.062778386001, 5127.948770502047, 5248.5276325130735, 5269.235960785689, 5332.093544097503, 5168.328117344749, 5226.660267082637, 5246.501582349681, 5264.263003179558, 5298.761555729991, 4673.649476289275, 4703.553162449571, 4751.0972915146185, 4844.32179494871, 4901.828436004741, 4660.0, 4835.202191638393, 4883.658143929926, 4896.338994235786, 4896.853094407174, 4686.156491831469, 4773.71357718538, 4780.115678599453, 4806.279058141272, 4833.250846118822, 4765.189917713997, 4765.21373973294, 4770.570648641639, 4777.617790576745, 4812.903741925177, 4717.43390793107, 4759.476457589697, 4780.4741478437345, 4787.6648634595595, 4794.304825800275, 5039.2944987701385, 5053.36832895888, 5128.384593848725, 5153.201253805666, 5166.638335316492, 5633.774649014034, 5644.717764111778, 5652.06740887753, 5656.095024796013, 5685.602007859451, 5517.475839795253, 5705.286839145107, 5710.600257981943, 5718.34239062509, 5724.370319264877, 5210.062188806013, 5251.4485978972425, 5261.1319132343115, 5264.0, 5293.602979776455, 5630.8029218977135, 5646.463585959327, 5658.377578466366, 5697.886042279214, 5710.743016564182, 5457.154141108134, 5476.7535460904355, 5506.752196151183, 5530.778768849201, 5534.640248383842, 5524.889502209933, 5563.276774019351, 5617.887642247132, 5620.409856965041, 5624.71876406178, 5522.806701765419, 5523.8066667666435, 5558.44415558441, 5629.887402251932, 5659.292588426447, 5586.050371436784, 5589.580781441408, 5595.608307418523, 5603.963266795656, 5626.662400255997, 4307.655387568987, 4343.609075183185, 4353.69524133314, 4355.695101342939, 4396.274614688605, 3814.48504451901, 3868.574456809749, 3888.51393575803, 3890.5525864525944, 3897.162110146332, 5085.1355269604255, 5093.032323858455, 5095.286659867622, 5102.387713474407, 5129.8204562840865, 5569.359523654751, 5570.58220633446, 5574.693391863405, 5576.553875689935, 5623.831285061455, 5079.87300317495, 5092.872678183001, 5100.821471248489, 5166.121759300928, 5194.039102766001, 4801.759912004456, 4808.422989241243, 4826.469088400273, 4827.444843842933, 4867.902641947141, 5850.882982340329, 5865.120231965154, 5870.295564532284, 5870.706464676835, 5871.178035075093, 5491.697956612425, 5520.1443776214755, 5533.833984980457, 5587.413321601173, 5589.10574308125, 5721.828345149652, 5730.512906402836, 5741.770329186786, 5744.971275143597, 5756.827295181151, 5448.373437054789, 5480.314960629921, 5480.753366098455, 5493.505584497414, 5497.725113744376, 5473.28847249855, 5515.917261241165, 5606.6636001840025, 5637.182608521659, 5646.209530665792, 5477.835664930059, 5482.150266708666, 5483.4516548344845, 5490.450954904478, 5515.696636685021, 5359.115745902039, 5445.646033007842, 5496.450354964471, 5498.1752737089755, 5550.0, 5366.168243922199, 5403.729813509231, 5405.351357837085, 5457.69982650958, 5479.945200547943, 5461.15352120422, 5472.343318801769, 5517.475839795213, 5521.503064724194, 5577.6653400796085, 5337.412884582771, 5366.463353664602, 5398.055340315507, 5405.756740946588, 5412.350517937873], "unit": "score", "name": "dojo.html", "value": 5165.685060671616}, {"lowerIsBetter": false, "replicates": [534.2520471340121, 535.7508758427331, 541.1990254423454, 557.8577462746999, 559.3735016781205, 27989.440211195764, 28528.714712852867, 38836.223275534474, 39217.21565568687, 39320.21359572807, 42073.789631051804, 42441.36337954933, 42448.0, 42645.14709705812, 42673.786631066876, 8607.268382187522, 8779.692710755126, 8811.603477843513, 8813.779655508599, 8820.558972051404, 8606.526641034741, 8730.956345218265, 8735.388522803407, 8735.432196907212, 8739.257163141141, 8759.036505984337, 8781.253593444564, 8811.823763524757, 8815.382923195379, 8819.162179592928, 8706.129387061306, 8755.255803256667, 8759.912400876005, 8767.912320876838, 8775.341849361259, 8615.396922215385, 8726.912730872673, 8733.475991440533, 8740.650373985032, 8744.562771861381, 38922.61077389218, 39336.0, 39419.0, 39428.21143577141, 39437.211255774724, 3105.580746599203, 3156.8579413926427, 3201.727853132463, 3242.659520750311, 3504.3516949364193, 29567.260818479495, 29741.851290743623, 29970.400591988036, 30660.540091898638, 30874.845625771726, 3936.4882565266616, 4034.45534852797, 4037.454943582608, 4049.817758200888, 4055.3511438169753, 195306.0, 195912.0, 195982.0, 196021.01989490105, 196112.0, 53131.73434132882, 54560.454395456334, 60594.394056058874, 61620.0, 61744.0, 52762.472375275756, 52804.0, 52977.0, 52979.47020529745, 53005.0, 15267.3893044277, 15796.526104216891, 16055.277512511731, 16245.918770406071, 16254.75617865733, 12396.876031239752, 12484.875151248552, 12485.687857803627, 12492.562760303346, 12499.50001999928, 19104.33134840274, 19165.808341916403, 19313.613727725366, 19599.0, 19602.0, 7730.342920851678, 7787.338076263468, 7906.248906353887, 7934.730443129071, 7991.800204994805, 837.5659794841224, 872.7992561710842, 929.7303781903307, 972.2805124208177, 1064.8988346107108, 29483.975448347235, 29545.11364659064, 29717.702822971925, 29868.402631947672, 30632.84683576568, 1081.3619964221148, 1097.1716354152722, 1099.4008265495165, 1148.62095508482, 1206.0773508266184, 14480.855191448161, 14809.0, 14828.851711482963, 16005.759913601305, 16250.918745406198, 238948.0, 240616.0, 240955.0, 241523.0, 243677.0, 51065.0, 51498.48501514937, 52160.47839521556, 52227.0, 52417.47582524126, 1330.5210124355417, 1385.9099158554661, 1386.7850483174923, 1390.7913812927939, 1396.3018490754623, 29174.27064323324, 29915.102546923627, 30332.393352133276, 30714.84642576773, 30861.382772344878, 42967.78516107525, 43290.13419731651, 43337.566624333354, 43403.13193736171, 43431.0, 230115.24711881668, 232451.0, 232750.0, 232801.0, 233538.0, 27363.589546156425, 30582.847085764428, 31092.22269443282, 31877.840610797724, 31902.68097318997, 37301.81349093237, 37340.813295933345, 37543.0, 37599.624003759614, 38251.0, 33351.49972750362, 35423.291534169686, 35439.468407973385, 35935.64064359428, 36728.63271367252, 28026.518396022682, 31638.367232654757, 32518.349633006736, 32574.51138232881, 33969.49045764365, 35503.82248088743, 36341.45487817738, 36388.0, 36678.08304792295, 36958.63041369552, 30857.537136943414, 31742.841285793424, 32385.838070810438, 32420.675793241764, 32539.837300813346, 24866.50266994686, 25398.365040874127, 25457.745422545537, 25703.871480642476, 25780.613290800276], "unit": "score", "name": "ext.html", "value": 17841.94873999432}, {"lowerIsBetter": false, "replicates": [373.46221441124777, 375.24388357459725, 375.66190428614254, 377.14012052520263, 379.60900272719107, 9843.950780246107, 10196.0, 11384.203105782599, 11846.526138954432, 16132.83867161328, 16999.065051422167, 17123.31506739732, 17526.211320490576, 17638.559036024108, 17658.0, 4425.092855964535, 5022.924656130161, 6064.666443345614, 6080.179175811275, 6082.939170608303, 6373.13962615048, 6718.361755633231, 6720.865582688343, 6721.966390168042, 6723.193216813989, 6624.867502649944, 6652.667366631673, 6788.049673045753, 6790.3549162829695, 6794.626295553742, 6422.2293324801085, 6670.099536562599, 6672.332766723337, 6689.163854518185, 6692.899606505906, 6311.179546658951, 6345.0482427636225, 6368.5860419072615, 6377.17096777416, 6379.234491861006, 21846.344609661737, 22178.556428871492, 22630.43423914399, 22851.200207992806, 22862.77137228623, 2100.4433825036376, 2138.283674968887, 2237.295251995616, 2472.5796614575565, 2969.9902033308563, 13307.534236301779, 13747.793783093262, 14156.362963666557, 14412.351444185037, 14436.206008669518, 1919.4721451600783, 1971.8323942464908, 1981.8711783734154, 2011.6580181369202, 2063.9690404643943, 66771.0, 66911.66544167297, 68323.3167668322, 68619.9999999995, 69035.0, 14537.636559086108, 15013.549593512213, 15015.624609384853, 15030.0, 15037.548873533811, 23494.177703780286, 23539.882300588386, 23558.764412356, 23679.763202367754, 23764.287071387887, 7020.122484689414, 7393.852122957511, 7727.304542591081, 7744.380449564022, 7804.0635123785505, 7111.217766045835, 7117.572945623279, 7159.105111861018, 7175.533590316612, 7506.924930750732, 4178.289690752579, 4348.630366418826, 4488.438945131858, 4531.546845315442, 4545.409096817392, 1828.506303298102, 1852.2220667319757, 1880.2009146112848, 1891.3285783546644, 1894.886306821595, 469.5023275328163, 867.7049803066988, 917.3532659475054, 999.7200783780553, 1000.2398177385094, 9670.854937175947, 10786.191035672357, 11025.889741102646, 11271.661850144344, 11530.308181509135, 468.94607120181615, 470.1443373060996, 475.7716296177854, 488.836239859651, 490.6687985609699, 5065.569426598707, 6040.365761595057, 6095.177151084636, 6216.912040392913, 6331.0, 504024.0, 526154.0, 528305.0, 531523.0, 541279.0, 75802.62098689581, 78029.0, 78222.0, 78654.606726966, 79262.6036869812, 1135.250734515216, 1160.124106299755, 1170.1925671286615, 1179.7699448607611, 1187.1689817128045, 15416.0, 15489.922550387177, 15497.380104795682, 15525.767113493532, 15856.0, 33834.49248261327, 34611.653883460844, 34737.82631086828, 35066.649333506335, 35409.29181416306, 48215.5178448211, 48328.758356207996, 48743.0, 48817.36235057664, 48824.75587622039, 7350.595717235389, 7389.926100738924, 7479.139898911695, 7607.923920760722, 7653.617319133909, 10755.408452535186, 11058.612948547085, 11465.713357166138, 11486.82769758471, 11846.58536951237, 9786.706398808046, 10119.645812396531, 10145.289829712145, 10249.948750256499, 10329.483525823829, 8203.343732501266, 9853.802923941625, 9921.900780992097, 9984.151347135285, 10011.449370284414, 9663.9033609663, 9958.601655933682, 10055.346402483816, 10197.184225261813, 10280.280380373302, 6923.792286231421, 7548.0, 7556.433267505069, 7558.206388329366, 7584.12782529994, 9109.407888487227, 9974.3017988743, 10361.4301213434, 10388.844167337345, 10587.311824731369], "unit": "score", "name": "jquery.html", "value": 8484.271861800624}, {"lowerIsBetter": false, "replicates": [1335.6208791756858, 1459.5986103821447, 1463.9414423423063, 1645.8683305335567, 1803.27868852459, 7210.639468026598, 7243.492955493111, 7361.043064401633, 7377.631118444083, 7380.114386273642, 7766.262205090507, 7957.323627491655, 8010.0, 8020.0, 8023.598820059003, 2046.4781480722395, 2095.8532902696816, 2096.014873009683, 2342.8360014798973, 2368.2658375903525, 2312.7571604981404, 2365.787079162875, 2366.065404165354, 2366.6213405855065, 2367.0413482539598, 2304.9423764405856, 2318.5710643530915, 2337.614293641556, 2367.3134790910617, 2368.9763102369016, 2349.365671268748, 2354.7292061412986, 2364.326167042393, 2367.9526409471887, 2391.4021494626345, 2356.7643235676464, 2362.2795047510504, 2382.702162229721, 2388.617821148608, 2399.700037495313, 7757.069151701832, 7796.025496812898, 7797.142314345418, 7802.063752349754, 7802.687892484294, 4890.339804126433, 5074.416442109168, 5075.873103172414, 5077.974610126963, 5083.262926875619, 3169.6513383527795, 3182.984085079583, 3231.7737758356925, 3299.868005279786, 3302.6036875575087, 1030.654730665228, 1054.3463052907246, 1078.229066217658, 1088.0207812968392, 1113.4711012269188, 10986.176036797273, 11091.611793587266, 11142.052925501343, 11152.163587730953, 11158.442077896072, 4308.46144231971, 4438.556144385536, 4478.373027776114, 4482.439695038121, 4486.910261794811, 9474.147326740627, 9525.714228573015, 9527.047295270417, 9539.046095390406, 9579.281553883488, 4973.925391119136, 5012.398512178489, 5032.043911656773, 5043.193089105725, 5046.066477701637, 4581.404417425713, 4582.404287442611, 4582.495925448198, 4589.35748995141, 4597.632189424838, 3565.322588708137, 3751.2122454284904, 3756.0, 3796.145867179918, 3849.2493963676816, 1251.1054595963747, 1260.4706023470164, 1270.28863836252, 1272.8918041966351, 1281.6667666406802, 1298.8116723075102, 1304.8368953880765, 1338.899582531314, 1365.7883028130655, 1365.7951307303983, 7461.888071678929, 7513.248675132443, 7513.737019204411, 7523.8495230095095, 7528.322450979329, 1117.7038084907506, 1131.1290306463977, 1135.517405102828, 1145.7422080032093, 1150.4937827355936, 5925.081612350093, 6049.909251361233, 6056.212692350055, 6056.454919057306, 6057.757689692363, 9188.356815023018, 9490.050994900455, 9591.136797688241, 9595.90404095964, 9669.516524173903, 9578.377405468622, 9598.232141428669, 9601.135897769234, 9613.807723845484, 9617.807643847224, 7292.234315396913, 7474.289942455458, 7477.85044299111, 7563.168051514329, 7570.848583028419, 7133.2153463117975, 7213.20654727969, 7230.276972302728, 7246.782596522113, 7258.0, 8528.872066918877, 8555.443896146731, 8600.741977740678, 8743.825123497367, 8744.169303916118, 8791.252743516872, 8809.163129502687, 8819.779505512413, 8966.955165224132, 8967.730968070968, 6800.727970881109, 6819.522633415613, 6876.587404755731, 6881.380675739208, 6884.827879303058, 6752.716983773067, 6911.343422374866, 6919.0, 7043.964780176067, 7595.924040759522, 6788.389044985975, 6828.487863410363, 6879.312068793281, 6935.133108361455, 6977.197622273504, 6545.345465453416, 6591.670416479253, 6606.0, 6686.732530698718, 6699.899501507579, 6751.459883209233, 6824.692888819915, 6833.384995350442, 6834.658267086526, 6842.0763196969765, 6372.968135159294, 6425.1968503937005, 6470.805875823733, 6520.934790652223, 6529.216494020748, 6523.64119973406, 6581.3418658133805, 6586.308437613981, 6587.934120658732, 6596.142501474777], "unit": "score", "name": "mootools.html", "value": 4596.902611810059}, {"lowerIsBetter": false, "replicates": [337.2210194450819, 343.82293119043715, 344.06071425009713, 344.7638367718113, 350.9771864828788, 5752.28096487939, 5779.682117483537, 5853.7951171709, 5855.795047173355, 5863.648181109136, 5501.889962200764, 5620.46605572471, 5634.183043458706, 5758.107493338529, 5796.82609521715, 4492.550744925514, 4506.436695413082, 4521.683482156251, 4537.069900670354, 4549.090181963604, 4308.676849236304, 4515.074409746011, 4529.456465224162, 4529.592336689697, 4537.047220083787, 4382.233109205877, 4475.28395456727, 4481.551844815525, 4485.753283569403, 4502.077074199781, 4435.379046933432, 4445.8221671133115, 4459.0, 4460.107978404332, 4465.508794032654, 3924.666403355718, 3930.803459827026, 3931.941020884689, 3934.881953541398, 3946.210757848413, 5407.648502847303, 5470.699111548864, 5487.42382049883, 5493.587980901449, 5505.03661859177, 5179.430262671103, 5216.478352164791, 5218.217267409881, 5222.556082732972, 5223.164293712987, 6117.755289788403, 6120.051392034242, 6126.571140020201, 6128.57100003, 6130.356312587159, 4381.058072514425, 4388.1004394099455, 4391.077873646538, 4393.494748103977, 4399.934000989988, 6252.906206406908, 6303.653299068549, 6381.712822922979, 6396.168498095218, 6409.391107844794, 4485.506594274627, 4485.923378389229, 4491.146682130385, 4492.415985921874, 4495.190865644216, 4544.18204723153, 4553.408056952575, 4555.157295900269, 4555.906582420195, 4558.407407037064, 5192.169252919514, 5194.428612852583, 5195.428502864682, 5197.610179236573, 5197.7401129943355, 6095.329513753483, 6156.138140660311, 6200.968995154995, 6204.81385558425, 6214.564980451415, 1604.0856711674235, 1604.8475394837471, 1620.8703303735672, 1620.9837901620833, 1622.059205660714, 1091.3124731419155, 1098.3080659184823, 1106.2975010868156, 1120.3389999900098, 1122.421952694363, 5766.163906233573, 5802.767889284466, 5819.73811178498, 5825.563082768809, 5825.737841797045, 6296.779612713624, 6318.557700960889, 6340.048992651139, 6346.8413289667205, 6351.460125889259, 5604.747786349624, 5647.068233741469, 5744.454276843693, 5762.798302059407, 5770.711464426762, 3378.7803792753393, 3412.436947903568, 3417.401954657975, 3425.143714071482, 3428.160100775276, 6589.6375699336995, 6614.7023383947835, 6634.966825165843, 6662.433693136138, 6663.633500157538, 6405.231372235362, 6550.0829883816305, 6565.737370505126, 6572.671366431659, 6576.671166441754, 6638.402543770987, 6638.502112341497, 6640.9667951660895, 6644.0, 6681.766138185238, 6385.265694445198, 6388.584741991755, 6410.9038364425505, 6412.519061070345, 6428.517861160525, 6165.630062196283, 6336.493080553452, 6336.58812177207, 6340.873182536416, 6354.23749150105, 6548.541602087808, 6550.279469258473, 6551.705173267119, 6557.147570815763, 6565.540412171103, 4492.303692927601, 4492.955070449384, 4533.320001999727, 4535.160995215896, 4540.273556230987, 6116.3883611638485, 6270.686465676789, 6274.874502509833, 6298.307186209422, 6301.180846489927, 6084.6349219047, 6121.724522396592, 6129.111278864629, 6138.324784273816, 6139.600925939978, 6103.328633850184, 6106.267247930276, 6112.541559383153, 6120.908186377297, 6124.081387791867, 5848.619839710405, 5974.880502389841, 5982.0, 5985.700714964148, 5989.7304621293015, 6149.292831324455, 6153.353897840662, 6163.660998644938, 6195.907061393992, 6208.968955155376, 6031.4270144336215, 6042.848928776816, 6043.184170137151, 6049.941260279522, 6054.515638748978], "unit": "score", "name": "prototype.html", "value": 4677.8527814862855}, {"lowerIsBetter": false, "replicates": [800.179367728756, 808.2765924497575, 813.6818354266088, 825.5830805443251, 826.3513142183388, 12394.504219831208, 12394.504219831208, 12425.689357766061, 12466.626001219978, 12506.124571280014, 10816.080633146172, 11763.470643821027, 11795.823062654066, 11806.704832379195, 11816.054715622751, 677.9152605924272, 830.6552780596045, 842.0695131879277, 843.3169133002257, 843.9409241353108, 838.7986883148061, 845.2350622686479, 846.255295340103, 846.6232526525698, 846.6782622603403, 717.6268340462956, 878.3456325037856, 878.6573236437795, 883.8541640629288, 884.5046773806657, 860.1355637584188, 870.8606622940363, 871.0984131424009, 871.538084815049, 872.0799556467924, 641.6695401867995, 641.9743210271583, 649.89276769333, 652.4519403700914, 652.4910569755551, 11897.94051029748, 12289.69275768104, 12296.323702196376, 12317.322547259897, 12334.259944403364, 12834.679133021657, 13166.210027398387, 13295.933520332337, 13298.135621184592, 13367.064305498521, 9319.487428191447, 9369.250459963187, 9590.568424420917, 9719.757006074835, 10527.368357898475, 3277.7899583424746, 3409.880654177092, 3438.570178727659, 3486.1981744198724, 3494.8427320770625, 45745.77127114376, 45754.31368529475, 45843.31235031477, 45972.77013614944, 47237.527624723654, 10093.495325233709, 10112.443815590213, 10155.746106347253, 10156.847647285149, 10295.897041029493, 18220.36228731988, 18336.083195840154, 18350.357737479124, 18612.906935465508, 18622.348217812312, 7432.62836858155, 7567.940488331638, 7578.355839753683, 7705.614719264015, 7724.995750552393, 4257.957420425818, 4288.2495563276925, 4338.739675619473, 4339.1972485090355, 4352.651787856964, 2973.8215707057648, 2999.925001874971, 3013.8794448222266, 3017.0, 3025.803322784056, 524.4833838668908, 553.590343146069, 556.5436342199439, 556.7772890843695, 570.0, 658.9308122647149, 701.5229643842237, 706.2161001288565, 717.6483523073761, 730.3098571849657, 8596.140385961355, 8845.69040083594, 9289.0, 9470.14768670823, 9654.420734755937, 578.095280885413, 589.5872888977733, 626.8213559135625, 632.7943418389042, 634.2294112653057, 4061.2080644274083, 4138.5654506276405, 4148.8133034012935, 4202.432671589358, 4262.70161088727, 51349.0, 52177.2173417399, 52389.0, 52410.21384679233, 52453.73773131186, 48499.272510912364, 48772.26841597379, 48924.510754892704, 49588.50411495911, 49730.25404618934, 38599.807000964815, 39539.604603953594, 39786.60213397887, 41303.38044929328, 41465.0, 8782.473051616924, 8936.597853096757, 8975.237104846161, 9035.232005279624, 9130.49782261982, 33646.0, 33829.66170338364, 33907.0, 34193.316133676686, 34749.13127171841, 41038.76883693494, 41218.0, 41609.0, 42284.15431691411, 42306.0, 11308.830367544659, 11400.201985860911, 11747.471363788822, 12104.939475302566, 12129.090318226345, 12187.51249949992, 12399.442025108712, 12526.624201273977, 12799.168054076456, 12809.487620495076, 11309.151813614177, 11621.941890290494, 11847.348395837967, 11901.583444579399, 12045.819312710491, 11244.437778111225, 11304.547818087512, 11372.147088968195, 11697.23967942081, 11778.0, 11387.316760994367, 11563.768724625628, 11681.88318116842, 11938.403079846146, 12368.876311237133, 9015.323850711355, 9077.137671921157, 9421.246300295823, 10029.69910902674, 10060.899391006289, 9323.440593564408, 9375.156235938799, 9956.352837065568, 10140.847887281549, 10454.947725261325], "unit": "score", "name": "yui.html", "value": 6254.503434794249}], "name": "dromaeo_css", "value": 6870.49074238861}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 115.0, 109.0, 112.0, 114.0, 112.0, 102.0, 111.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.6}, {"lowerIsBetter": true, "replicates": [160.0, 151.0, 154.0, 170.0, 129.0, 160.0, 146.0, 129.0, 171.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 160.0, 160.0, 162.0, 162.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 98.0, 100.0, 72.0, 72.0, 72.0, 102.0, 100.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 141.0, 95.0, 96.0, 96.0, 142.0, 96.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [118.0, 115.0, 115.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 58.0, 58.0, 63.0, 57.0, 57.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [86.0, 92.0, 87.0, 86.0, 86.0, 86.0, 85.0, 87.0, 84.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [115.0, 115.0, 115.0, 116.0, 121.0, 118.0, 125.0, 122.0, 116.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.5}, {"lowerIsBetter": true, "replicates": [153.0, 139.0, 149.0, 155.0, 154.0, 144.0, 158.0, 164.0, 163.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.8}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 67.0, 70.0, 70.0, 68.0, 68.0, 69.0, 69.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1526.3000000000002}]} 17:29:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1526.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6870.49"}}} 17:29:56 INFO - Return code: 0 17:29:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:29:56 INFO - # TBPL SUCCESS # 17:29:56 INFO - Running post-action listener: _resource_record_post_action 17:29:56 INFO - Running post-run listener: _resource_record_post_run 17:29:57 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 577536; Write bytes: 370855936; Read time: 528; Write time: 235760 17:29:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 76931072; Read time: 156; Write time: 67220 17:29:57 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 573440; Write bytes: 293924864; Read time: 372; Write time: 168540 17:29:57 INFO - Running post-run listener: _upload_blobber_files 17:29:57 INFO - Blob upload gear active. 17:29:57 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 17:29:57 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 17:29:57 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'] 17:29:57 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 17:29:57 INFO - (blobuploader) - INFO - Open directory for files ... 17:29:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:29:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:29:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:58 INFO - (blobuploader) - INFO - Done attempting. 17:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 17:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:29:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:29:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:29:59 INFO - (blobuploader) - INFO - Done attempting. 17:29:59 INFO - (blobuploader) - INFO - Iteration through files over. 17:29:59 INFO - Return code: 0 17:29:59 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 17:29:59 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 17:29:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f8dd2679ce9f27ef1a8e4d4736a4873307ab39b67d7955a94634dca4f9081b42311303ceae0aae872c9601eb36661c446744a11038d0716d49b38145b269a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/751851b5063daf2209afc93dfb567ec04f2e9cc71856d96c5eb52845dd917d1a2e5b5d327afc2686c26df3151d7f308a8217b803d5955da038bcfc83aa28cda7"} 17:29:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 17:29:59 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 17:29:59 INFO - Contents: 17:29:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6f8dd2679ce9f27ef1a8e4d4736a4873307ab39b67d7955a94634dca4f9081b42311303ceae0aae872c9601eb36661c446744a11038d0716d49b38145b269a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/751851b5063daf2209afc93dfb567ec04f2e9cc71856d96c5eb52845dd917d1a2e5b5d327afc2686c26df3151d7f308a8217b803d5955da038bcfc83aa28cda7"} 17:29:59 INFO - Running post-run listener: copy_logs_to_upload_dir 17:29:59 INFO - Copying logs to upload dir... 17:29:59 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 17:29:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.650722 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-02-06 17:29:59.520469) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 17:29:59.523720) ========= 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 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/f6f8dd2679ce9f27ef1a8e4d4736a4873307ab39b67d7955a94634dca4f9081b42311303ceae0aae872c9601eb36661c446744a11038d0716d49b38145b269a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/751851b5063daf2209afc93dfb567ec04f2e9cc71856d96c5eb52845dd917d1a2e5b5d327afc2686c26df3151d7f308a8217b803d5955da038bcfc83aa28cda7"} build_url:https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/HleVtxlsRmSBm8TBPWidhQ/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/f6f8dd2679ce9f27ef1a8e4d4736a4873307ab39b67d7955a94634dca4f9081b42311303ceae0aae872c9601eb36661c446744a11038d0716d49b38145b269a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/751851b5063daf2209afc93dfb567ec04f2e9cc71856d96c5eb52845dd917d1a2e5b5d327afc2686c26df3151d7f308a8217b803d5955da038bcfc83aa28cda7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-06 17:29:59.548600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:29:59.548969) ========= 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=0333a256a5e4f052382dd180000001b1-1454803843.164081-1373396965 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-06 17:29:59.633448) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 17:29:59.633794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-06 17:29:59.634120) ========= ========= Total master_lag: 0.31 =========