builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1455208934.29 results: success (0) buildid: 20160211071132 builduid: 5bbad53408c9416ea875518efed1b061 revision: fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.287226) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.287671) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.287967) ========= bash -c pwd in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.319866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.320378) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.361705) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.362019) ========= rm -rf properties in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.414932) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.415196) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.415534) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.415815) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-11 08:42:15-- 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.3M=0s 2016-02-11 08:42:15 (64.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.534637) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.535265) ========= rm -rf scripts in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022297 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.584668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:14.585014) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-11 08:42:15,300 truncating revision to first 12 chars 2016-02-11 08:42:15,300 Setting DEBUG logging. 2016-02-11 08:42:15,300 attempt 1/10 2016-02-11 08:42:15,300 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe8b8550ff4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-11 08:42:15,552 unpacking tar archive at: fx-team-fe8b8550ff4b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542462 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:15.139901) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:15.140233) ========= echo fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e'] 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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e program finished with exit code 0 elapsedTime=0.003355 script_repo_revision: 'fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:15.188284) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:15.188660) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-11 08:42:15.209109) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-02-11 08:42:15.209395) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:16 INFO - MultiFileLogger online at 20160211 08:42:16 in /builds/slave/test 08:42:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:42:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:16 INFO - {'append_to_log': False, 08:42:16 INFO - 'base_work_dir': '/builds/slave/test', 08:42:16 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:42:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:16 INFO - 'branch': 'Fx-Team-Non-PGO', 08:42:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:16 INFO - 'config_files': ('talos/linux_config.py',), 08:42:16 INFO - 'default_actions': ('clobber', 08:42:16 INFO - 'read-buildbot-config', 08:42:16 INFO - 'download-and-extract', 08:42:16 INFO - 'populate-webroot', 08:42:16 INFO - 'create-virtualenv', 08:42:16 INFO - 'install', 08:42:16 INFO - 'run-tests'), 08:42:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:16 INFO - 'download_minidump_stackwalk': True, 08:42:16 INFO - 'download_symbols': 'ondemand', 08:42:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:16 INFO - 'installer_path': 'installer.exe', 08:42:16 INFO - 'log_level': 'info', 08:42:16 INFO - 'log_name': 'talos', 08:42:16 INFO - 'log_to_console': True, 08:42:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:16 INFO - 'opt_config_files': (), 08:42:16 INFO - 'pip_index': False, 08:42:16 INFO - 'sps_profile': False, 08:42:16 INFO - 'sps_profile_interval': 0, 08:42:16 INFO - 'suite': 'dromaeojs', 08:42:16 INFO - 'system_bits': '32', 08:42:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:16 INFO - 'title': 'talos-linux64-ix-065', 08:42:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:16 INFO - 'use_talos_json': True, 08:42:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:16 INFO - 'work_dir': 'build'} 08:42:16 INFO - ##### 08:42:16 INFO - ##### Running clobber step. 08:42:16 INFO - ##### 08:42:16 INFO - Running pre-action listener: _resource_record_pre_action 08:42:16 INFO - Running main action method: clobber 08:42:16 INFO - rmtree: /builds/slave/test/build 08:42:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:16 INFO - Running post-action listener: _resource_record_post_action 08:42:16 INFO - ##### 08:42:16 INFO - ##### Running read-buildbot-config step. 08:42:16 INFO - ##### 08:42:16 INFO - Running pre-action listener: _resource_record_pre_action 08:42:16 INFO - Running main action method: read_buildbot_config 08:42:16 INFO - Using buildbot properties: 08:42:16 INFO - { 08:42:16 INFO - "project": "", 08:42:16 INFO - "product": "firefox", 08:42:16 INFO - "script_repo_revision": "production", 08:42:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:42:16 INFO - "repository": "", 08:42:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:42:16 INFO - "buildid": "20160211071132", 08:42:16 INFO - "pgo_build": "False", 08:42:16 INFO - "basedir": "/builds/slave/test", 08:42:16 INFO - "buildnumber": 1298, 08:42:16 INFO - "slavename": "talos-linux64-ix-065", 08:42:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:42:16 INFO - "platform": "ubuntu64_hw", 08:42:16 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:42:16 INFO - "branch": "fx-team", 08:42:16 INFO - "repo_path": "integration/fx-team", 08:42:16 INFO - "revision": "fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e", 08:42:16 INFO - "stage_platform": "linux64", 08:42:16 INFO - "builduid": "5bbad53408c9416ea875518efed1b061", 08:42:16 INFO - "slavebuilddir": "test" 08:42:16 INFO - } 08:42:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 08:42:16 INFO - Running post-action listener: _resource_record_post_action 08:42:16 INFO - ##### 08:42:16 INFO - ##### Running download-and-extract step. 08:42:16 INFO - ##### 08:42:16 INFO - Running pre-action listener: _resource_record_pre_action 08:42:16 INFO - Running main action method: download_and_extract 08:42:16 INFO - mkdir: /builds/slave/test/build/tests 08:42: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')]} 08:42:16 INFO - https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:42:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/test_packages.json 08:42:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/test_packages.json 08:42:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:42:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:42:21 INFO - Downloaded 1448 bytes. 08:42:21 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:42:21 INFO - Using the following test package requirements: 08:42:21 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:21 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:21 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:42:21 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'jsshell-linux-x86_64.zip'], 08:42:21 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:21 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:21 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:42:21 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:42:21 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:21 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:21 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:21 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:21 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:21 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')]} 08:42:21 INFO - https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:42:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:42:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:42:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:23 INFO - Downloaded 21982646 bytes. 08:42:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:24 INFO - Return code: 0 08:42:24 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 08:42:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:24 INFO - https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:42:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:42:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:42:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 08:42:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:25 INFO - Downloaded 21982646 bytes. 08:42:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 08:42:27 INFO - Return code: 0 08:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:27 INFO - https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:42:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:42:27 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:27 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 08:42:27 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 08:42:27 INFO - Server: 10.26.75.40 08:42:27 INFO - Address: 10.26.75.40#53 08:42:27 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 08:42:27 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 08:42:27 INFO - Address: 10.26.48.46 08:42:27 INFO - Return code: 0 08:42:27 INFO - retry: attempt #1 caught exception: 08:42:27 INFO - retry: Failed, sleeping 30 seconds before retrying 08:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 08:42:58 INFO - Downloaded 10706547 bytes. 08:42:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:42:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 08:42:58 INFO - Return code: 0 08:42:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:58 INFO - https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:42:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:42:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:42:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:42:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:42:59 INFO - Downloaded 54599682 bytes. 08:42:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:42:59 INFO - mkdir: /builds/slave/test/properties 08:42:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:59 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:59 INFO - Contents: 08:42:59 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 08:43:00 INFO - Running post-action listener: _resource_record_post_action 08:43:00 INFO - Running post-action listener: set_extra_try_arguments 08:43:00 INFO - ##### 08:43:00 INFO - ##### Running populate-webroot step. 08:43:00 INFO - ##### 08:43:00 INFO - Running pre-action listener: _resource_record_pre_action 08:43:00 INFO - Running main action method: populate_webroot 08:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:00 INFO - '--tppagecycles', 08:43:00 INFO - '7'], 08:43:00 INFO - 'tests': ['tsvgm']}}, 08:43:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:43:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 08:43:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'tests': ['damp', 'tps']}, 08:43:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['damp', 'tps']}, 08:43:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:00 INFO - 'other': {'tests': ['a11yr', 08:43:00 INFO - 'ts_paint', 08:43:00 INFO - 'tpaint', 08:43:00 INFO - 'sessionrestore', 08:43:00 INFO - 'sessionrestore_no_auto_restore']}, 08:43:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['a11yr', 08:43:00 INFO - 'ts_paint', 08:43:00 INFO - 'tpaint', 08:43:00 INFO - 'sessionrestore', 08:43:00 INFO - 'sessionrestore_no_auto_restore']}, 08:43:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['a11yr', 08:43:00 INFO - 'ts_paint', 08:43:00 INFO - 'tpaint', 08:43:00 INFO - 'sessionrestore', 08:43:00 INFO - 'sessionrestore_no_auto_restore']}, 08:43:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['a11yr', 08:43:00 INFO - 'ts_paint', 08:43:00 INFO - 'tpaint', 08:43:00 INFO - 'sessionrestore', 08:43:00 INFO - 'sessionrestore_no_auto_restore']}, 08:43:00 INFO - 'other_l64': {'tests': ['a11yr', 08:43:00 INFO - 'ts_paint', 08:43:00 INFO - 'tpaint', 08:43:00 INFO - 'sessionrestore', 08:43:00 INFO - 'sessionrestore_no_auto_restore']}, 08:43:00 INFO - 'other_nol64': {'tests': ['a11yr', 08:43:00 INFO - 'ts_paint', 08:43:00 INFO - 'tpaint', 08:43:00 INFO - 'sessionrestore', 08:43:00 INFO - 'sessionrestore_no_auto_restore']}, 08:43:00 INFO - 'svgr': {'tests': ['tsvgx', 08:43:00 INFO - 'tsvgr_opacity', 08:43:00 INFO - 'tart', 08:43:00 INFO - 'tscrollx', 08:43:00 INFO - 'cart']}, 08:43:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['tsvgx', 08:43:00 INFO - 'tsvgr_opacity', 08:43:00 INFO - 'tart', 08:43:00 INFO - 'tscrollx', 08:43:00 INFO - 'cart']}, 08:43:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'tests': ['tp5o']}, 08:43:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'talos_options': ['--e10s'], 08:43:00 INFO - 'tests': ['tp5o']}, 08:43:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'talos_options': ['--xperf_path', 08:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:00 INFO - 'tests': ['tp5n']}, 08:43:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:00 INFO - 'talos_options': ['--e10s', 08:43:00 INFO - '--xperf_path', 08:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:00 INFO - 'tests': ['tp5n']}}, 08:43:00 INFO - 'talos.zip': {'path': '', 08:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:00 INFO - Running post-action listener: _resource_record_post_action 08:43:00 INFO - ##### 08:43:00 INFO - ##### Running create-virtualenv step. 08:43:00 INFO - ##### 08:43:00 INFO - Running pre-action listener: _resource_record_pre_action 08:43:00 INFO - Running main action method: create_virtualenv 08:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:00 INFO - Using real prefix '/usr' 08:43:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:01 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:03 INFO - Installing pip.................done. 08:43:03 INFO - Return code: 0 08:43:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:03 INFO - Running command: ['/builds/slave/test/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/build 08:43:03 INFO - Copy/paste: /builds/slave/test/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 08:43:03 INFO - Using env: {'DISPLAY': ':0', 08:43:03 INFO - 'HOME': '/home/cltbld', 08:43:03 INFO - 'LANG': 'en_US.UTF-8', 08:43:03 INFO - 'LANGUAGE': 'en_US:en', 08:43:03 INFO - 'LOGNAME': 'cltbld', 08:43:03 INFO - 'MAIL': '/var/mail/cltbld', 08:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:03 INFO - 'MOZ_NO_REMOTE': '1', 08:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:03 INFO - 'NO_EM_RESTART': '1', 08:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:03 INFO - 'PWD': '/builds/slave/test', 08:43:03 INFO - 'SHELL': '/bin/bash', 08:43:03 INFO - 'SHLVL': '1', 08:43:03 INFO - 'TERM': 'linux', 08:43:03 INFO - 'TMOUT': '86400', 08:43:03 INFO - 'USER': 'cltbld', 08:43:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:03 INFO - '_': '/tools/buildbot/bin/python'} 08:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:03 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 08:43:03 INFO - Cleaning up... 08:43:03 INFO - Return code: 0 08:43:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:03 INFO - Running command: ['/builds/slave/test/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/build 08:43:03 INFO - Copy/paste: /builds/slave/test/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 08:43:03 INFO - Using env: {'DISPLAY': ':0', 08:43:03 INFO - 'HOME': '/home/cltbld', 08:43:03 INFO - 'LANG': 'en_US.UTF-8', 08:43:03 INFO - 'LANGUAGE': 'en_US:en', 08:43:03 INFO - 'LOGNAME': 'cltbld', 08:43:03 INFO - 'MAIL': '/var/mail/cltbld', 08:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:03 INFO - 'MOZ_NO_REMOTE': '1', 08:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:03 INFO - 'NO_EM_RESTART': '1', 08:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:03 INFO - 'PWD': '/builds/slave/test', 08:43:03 INFO - 'SHELL': '/bin/bash', 08:43:03 INFO - 'SHLVL': '1', 08:43:03 INFO - 'TERM': 'linux', 08:43:03 INFO - 'TMOUT': '86400', 08:43:03 INFO - 'USER': 'cltbld', 08:43:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:03 INFO - '_': '/tools/buildbot/bin/python'} 08:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:03 INFO - Downloading/unpacking psutil>=0.7.1 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:05 INFO - Installing collected packages: psutil 08:43:05 INFO - Running setup.py install for psutil 08:43:05 INFO - building 'psutil._psutil_linux' extension 08:43:05 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 08:43:05 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 08:43:05 INFO - building 'psutil._psutil_posix' extension 08:43:05 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 08:43:05 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 08:43:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:06 INFO - Successfully installed psutil 08:43:06 INFO - Cleaning up... 08:43:06 INFO - Return code: 0 08:43:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:43:06 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')]} 08:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 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')]} 08:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:06 INFO - Running command: ['/builds/slave/test/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/build 08:43:06 INFO - Copy/paste: /builds/slave/test/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 08:43:06 INFO - Using env: {'DISPLAY': ':0', 08:43:06 INFO - 'HOME': '/home/cltbld', 08:43:06 INFO - 'LANG': 'en_US.UTF-8', 08:43:06 INFO - 'LANGUAGE': 'en_US:en', 08:43:06 INFO - 'LOGNAME': 'cltbld', 08:43:06 INFO - 'MAIL': '/var/mail/cltbld', 08:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:06 INFO - 'MOZ_NO_REMOTE': '1', 08:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:06 INFO - 'NO_EM_RESTART': '1', 08:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:06 INFO - 'PWD': '/builds/slave/test', 08:43:06 INFO - 'SHELL': '/bin/bash', 08:43:06 INFO - 'SHLVL': '1', 08:43:06 INFO - 'TERM': 'linux', 08:43:06 INFO - 'TMOUT': '86400', 08:43:06 INFO - 'USER': 'cltbld', 08:43:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:06 INFO - '_': '/tools/buildbot/bin/python'} 08:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:43:06 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 08:43:06 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 08:43:06 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 08:43:06 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 08:43:06 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 08:43:06 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 08:43:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:43:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:43:11 INFO - Installing collected packages: mozsystemmonitor 08:43:11 INFO - Running setup.py install for mozsystemmonitor 08:43:11 INFO - Successfully installed mozsystemmonitor 08:43:11 INFO - Cleaning up... 08:43:11 INFO - Return code: 0 08:43:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:11 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')]} 08:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:11 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')]} 08:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:11 INFO - Running command: ['/builds/slave/test/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/build 08:43:11 INFO - Copy/paste: /builds/slave/test/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 08:43:11 INFO - Using env: {'DISPLAY': ':0', 08:43:11 INFO - 'HOME': '/home/cltbld', 08:43:11 INFO - 'LANG': 'en_US.UTF-8', 08:43:11 INFO - 'LANGUAGE': 'en_US:en', 08:43:11 INFO - 'LOGNAME': 'cltbld', 08:43:11 INFO - 'MAIL': '/var/mail/cltbld', 08:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:11 INFO - 'MOZ_NO_REMOTE': '1', 08:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:11 INFO - 'NO_EM_RESTART': '1', 08:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:11 INFO - 'PWD': '/builds/slave/test', 08:43:11 INFO - 'SHELL': '/bin/bash', 08:43:11 INFO - 'SHLVL': '1', 08:43:11 INFO - 'TERM': 'linux', 08:43:11 INFO - 'TMOUT': '86400', 08:43:11 INFO - 'USER': 'cltbld', 08:43:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:11 INFO - '_': '/tools/buildbot/bin/python'} 08:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:11 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 08:43:11 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 08:43:11 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 08:43:11 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 08:43:11 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 08:43:11 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 08:43:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 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 08:43:13 INFO - Downloading docopt-0.6.1.tar.gz 08:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:13 INFO - Running setup.py install for blobuploader 08:43:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:14 INFO - Running setup.py install for requests 08:43:14 INFO - Running setup.py install for docopt 08:43:14 INFO - Successfully installed blobuploader requests docopt 08:43:14 INFO - Cleaning up... 08:43:14 INFO - Return code: 0 08:43:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 08:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 08:43:14 INFO - Using env: {'DISPLAY': ':0', 08:43:14 INFO - 'HOME': '/home/cltbld', 08:43:14 INFO - 'LANG': 'en_US.UTF-8', 08:43:14 INFO - 'LANGUAGE': 'en_US:en', 08:43:14 INFO - 'LOGNAME': 'cltbld', 08:43:14 INFO - 'MAIL': '/var/mail/cltbld', 08:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:14 INFO - 'MOZ_NO_REMOTE': '1', 08:43:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:14 INFO - 'NO_EM_RESTART': '1', 08:43:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:14 INFO - 'PWD': '/builds/slave/test', 08:43:14 INFO - 'SHELL': '/bin/bash', 08:43:14 INFO - 'SHLVL': '1', 08:43:14 INFO - 'TERM': 'linux', 08:43:14 INFO - 'TMOUT': '86400', 08:43:14 INFO - 'USER': 'cltbld', 08:43:14 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:14 INFO - '_': '/tools/buildbot/bin/python'} 08:43:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:14 INFO - Running setup.py (path:/tmp/pip-ptr4j2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:14 INFO - Running setup.py (path:/tmp/pip-4O4Ume-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:14 INFO - Running setup.py (path:/tmp/pip-9dB_nr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:14 INFO - Running setup.py (path:/tmp/pip-kkoe6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:15 INFO - Running setup.py (path:/tmp/pip-VT0xwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:15 INFO - Running setup.py (path:/tmp/pip-6W1GsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:15 INFO - Running setup.py (path:/tmp/pip-vU284v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:15 INFO - Running setup.py (path:/tmp/pip-w8ttW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:15 INFO - Running setup.py (path:/tmp/pip-875QKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:15 INFO - Running setup.py (path:/tmp/pip-T_wHr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:15 INFO - Running setup.py (path:/tmp/pip-XB0tlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:15 INFO - Running setup.py (path:/tmp/pip-47cUID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:15 INFO - Running setup.py (path:/tmp/pip-kbinQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:15 INFO - Running setup.py (path:/tmp/pip-Q7It5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:15 INFO - Running setup.py (path:/tmp/pip-nFUOi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:15 INFO - Running setup.py (path:/tmp/pip-QSvP3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:15 INFO - Running setup.py (path:/tmp/pip-Nu3OGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:16 INFO - Running setup.py install for manifestparser 08:43:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozcrash 08:43:16 INFO - Running setup.py install for mozdebug 08:43:16 INFO - Running setup.py install for mozdevice 08:43:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozfile 08:43:16 INFO - Running setup.py install for mozhttpd 08:43:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozinfo 08:43:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozInstall 08:43:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:16 INFO - Running setup.py install for mozleak 08:43:16 INFO - Running setup.py install for mozlog 08:43:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for moznetwork 08:43:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozprocess 08:43:17 INFO - Running setup.py install for mozprofile 08:43:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozrunner 08:43:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Running setup.py install for mozscreenshot 08:43:17 INFO - Running setup.py install for moztest 08:43:17 INFO - Running setup.py install for mozversion 08:43:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:17 INFO - Cleaning up... 08:43:17 INFO - Return code: 0 08:43:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 08:43:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 08:43:17 INFO - Using env: {'DISPLAY': ':0', 08:43:17 INFO - 'HOME': '/home/cltbld', 08:43:17 INFO - 'LANG': 'en_US.UTF-8', 08:43:17 INFO - 'LANGUAGE': 'en_US:en', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MAIL': '/var/mail/cltbld', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SHLVL': '1', 08:43:17 INFO - 'TERM': 'linux', 08:43:17 INFO - 'TMOUT': '86400', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - '_': '/tools/buildbot/bin/python'} 08:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:18 INFO - Running setup.py (path:/tmp/pip-YMG5rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:18 INFO - Running setup.py (path:/tmp/pip-sXRxme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:18 INFO - Running setup.py (path:/tmp/pip-A81ohD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:18 INFO - Running setup.py (path:/tmp/pip-hLz6HP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:18 INFO - Running setup.py (path:/tmp/pip-ewaIY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:18 INFO - Running setup.py (path:/tmp/pip-uiI6vV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:18 INFO - Running setup.py (path:/tmp/pip-ThxpHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:18 INFO - Running setup.py (path:/tmp/pip-5FxtRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:18 INFO - Running setup.py (path:/tmp/pip-3I1krL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:18 INFO - Running setup.py (path:/tmp/pip-VJ27tp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:18 INFO - Running setup.py (path:/tmp/pip-Iz1cPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:18 INFO - Running setup.py (path:/tmp/pip-fjBPRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:18 INFO - Running setup.py (path:/tmp/pip-_zJPnI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:43:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:18 INFO - Running setup.py (path:/tmp/pip-t5fpBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:19 INFO - Running setup.py (path:/tmp/pip-6fezFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:19 INFO - Running setup.py (path:/tmp/pip-1_qIoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:43:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:19 INFO - Running setup.py (path:/tmp/pip-xKInR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:43:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43:19 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 08:43:19 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 08:43:19 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 08:43:19 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 08:43:19 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 08:43:19 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 08:43:21 INFO - Downloading blessings-1.6.tar.gz 08:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:21 INFO - Installing collected packages: blessings 08:43:21 INFO - Running setup.py install for blessings 08:43:21 INFO - Successfully installed blessings 08:43:21 INFO - Cleaning up... 08:43:21 INFO - Return code: 0 08:43:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:21 INFO - Reading from file tmpfile_stdout 08:43:21 INFO - Current package versions: 08:43:21 INFO - argparse == 1.2.1 08:43:21 INFO - blessings == 1.6 08:43:21 INFO - blobuploader == 1.2.4 08:43:21 INFO - docopt == 0.6.1 08:43:21 INFO - manifestparser == 1.1 08:43:21 INFO - mozInstall == 1.12 08:43:21 INFO - mozcrash == 0.16 08:43:21 INFO - mozdebug == 0.1 08:43:21 INFO - mozdevice == 0.48 08:43:21 INFO - mozfile == 1.2 08:43:21 INFO - mozhttpd == 0.7 08:43:21 INFO - mozinfo == 0.9 08:43:21 INFO - mozleak == 0.1 08:43:21 INFO - mozlog == 3.1 08:43:21 INFO - moznetwork == 0.27 08:43:21 INFO - mozprocess == 0.22 08:43:21 INFO - mozprofile == 0.28 08:43:21 INFO - mozrunner == 6.11 08:43:21 INFO - mozscreenshot == 0.1 08:43:21 INFO - mozsystemmonitor == 0.0 08:43:21 INFO - moztest == 0.7 08:43:21 INFO - mozversion == 1.4 08:43:21 INFO - psutil == 3.1.1 08:43:21 INFO - requests == 1.2.3 08:43:21 INFO - wsgiref == 0.1.2 08:43:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:21 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')]} 08:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 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')]} 08:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 08:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 08:43:21 INFO - Using env: {'DISPLAY': ':0', 08:43:21 INFO - 'HOME': '/home/cltbld', 08:43:21 INFO - 'LANG': 'en_US.UTF-8', 08:43:21 INFO - 'LANGUAGE': 'en_US:en', 08:43:21 INFO - 'LOGNAME': 'cltbld', 08:43:21 INFO - 'MAIL': '/var/mail/cltbld', 08:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:21 INFO - 'MOZ_NO_REMOTE': '1', 08:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:21 INFO - 'NO_EM_RESTART': '1', 08:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:21 INFO - 'PWD': '/builds/slave/test', 08:43:21 INFO - 'SHELL': '/bin/bash', 08:43:21 INFO - 'SHLVL': '1', 08:43:21 INFO - 'TERM': 'linux', 08:43:21 INFO - 'TMOUT': '86400', 08:43:21 INFO - 'USER': 'cltbld', 08:43:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:21 INFO - '_': '/tools/buildbot/bin/python'} 08:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:43:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:43:21 INFO - Cleaning up... 08:43:21 INFO - Return code: 0 08:43:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:21 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')]} 08:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 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')]} 08:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:21 INFO - Running command: ['/builds/slave/test/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/build 08:43:21 INFO - Copy/paste: /builds/slave/test/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 08:43:21 INFO - Using env: {'DISPLAY': ':0', 08:43:21 INFO - 'HOME': '/home/cltbld', 08:43:21 INFO - 'LANG': 'en_US.UTF-8', 08:43:21 INFO - 'LANGUAGE': 'en_US:en', 08:43:21 INFO - 'LOGNAME': 'cltbld', 08:43:21 INFO - 'MAIL': '/var/mail/cltbld', 08:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:21 INFO - 'MOZ_NO_REMOTE': '1', 08:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:21 INFO - 'NO_EM_RESTART': '1', 08:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:21 INFO - 'PWD': '/builds/slave/test', 08:43:21 INFO - 'SHELL': '/bin/bash', 08:43:21 INFO - 'SHLVL': '1', 08:43:21 INFO - 'TERM': 'linux', 08:43:21 INFO - 'TMOUT': '86400', 08:43:21 INFO - 'USER': 'cltbld', 08:43:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:21 INFO - '_': '/tools/buildbot/bin/python'} 08:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:21 INFO - Downloading/unpacking jsonschema 08:43:21 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 08:43:21 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 08:43:21 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 08:43:21 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 08:43:21 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 08:43:21 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 08:43:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:23 INFO - Downloading/unpacking functools32 (from jsonschema) 08:43:23 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 08:43:23 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 08:43:23 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 08:43:23 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 08:43:23 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 08:43:23 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 08:43:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:23 INFO - warning: no files found matching '*.txt' 08:43:23 INFO - no previously-included directories found matching 'build' 08:43:23 INFO - no previously-included directories found matching 'dist' 08:43:23 INFO - no previously-included directories found matching '.git*' 08:43:23 INFO - Installing collected packages: jsonschema, functools32 08:43:24 INFO - Running setup.py install for functools32 08:43:24 INFO - warning: no files found matching '*.txt' 08:43:24 INFO - no previously-included directories found matching 'build' 08:43:24 INFO - no previously-included directories found matching 'dist' 08:43:24 INFO - no previously-included directories found matching '.git*' 08:43:24 INFO - Successfully installed jsonschema functools32 08:43:24 INFO - Cleaning up... 08:43:24 INFO - Return code: 0 08:43:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f6cb25a9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ffa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20c73b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 08:43:24 INFO - Running command: ['/builds/slave/test/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/build 08:43:24 INFO - Copy/paste: /builds/slave/test/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 08:43:24 INFO - Using env: {'DISPLAY': ':0', 08:43:24 INFO - 'HOME': '/home/cltbld', 08:43:24 INFO - 'LANG': 'en_US.UTF-8', 08:43:24 INFO - 'LANGUAGE': 'en_US:en', 08:43:24 INFO - 'LOGNAME': 'cltbld', 08:43:24 INFO - 'MAIL': '/var/mail/cltbld', 08:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:24 INFO - 'MOZ_NO_REMOTE': '1', 08:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:24 INFO - 'NO_EM_RESTART': '1', 08:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:24 INFO - 'PWD': '/builds/slave/test', 08:43:24 INFO - 'SHELL': '/bin/bash', 08:43:24 INFO - 'SHLVL': '1', 08:43:24 INFO - 'TERM': 'linux', 08:43:24 INFO - 'TMOUT': '86400', 08:43:24 INFO - 'USER': 'cltbld', 08:43:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:24 INFO - '_': '/tools/buildbot/bin/python'} 08:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:24 INFO - Downloading/unpacking flake8 08:43:24 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 08:43:24 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 08:43:24 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 08:43:24 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 08:43:24 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 08:43:24 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 08:43:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:43:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:43:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:26 INFO - no previously-included directories found matching 'docs/_build' 08:43:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:43:26 INFO - Running setup.py install for pep8 08:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:43:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:43:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:43:26 INFO - no previously-included directories found matching 'docs/_build' 08:43:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:43:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:43:27 INFO - Cleaning up... 08:43:27 INFO - Return code: 0 08:43:27 INFO - Running post-action listener: _resource_record_post_action 08:43:27 INFO - Running post-action listener: _start_resource_monitoring 08:43:27 INFO - Starting resource monitoring. 08:43:27 INFO - ##### 08:43:27 INFO - ##### Running install step. 08:43:27 INFO - ##### 08:43:27 INFO - Running pre-action listener: _resource_record_pre_action 08:43:27 INFO - Running main action method: install 08:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:27 INFO - Reading from file tmpfile_stdout 08:43:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:27 INFO - Reading from file tmpfile_stdout 08:43:27 INFO - Output received: 08:43:27 INFO - Usage: mozinstall [options] installer 08:43:27 INFO - Options: 08:43:27 INFO - -h, --help show this help message and exit 08:43:27 INFO - -d DEST, --destination=DEST 08:43:27 INFO - Directory to install application into. [default: 08:43:27 INFO - "/builds/slave/test"] 08:43:27 INFO - --app=APP Application being installed. [default: firefox] 08:43:27 INFO - mkdir: /builds/slave/test/build/application 08:43:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:43:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:43:43 INFO - Reading from file tmpfile_stdout 08:43:43 INFO - Output received: 08:43:43 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:43 INFO - Running post-action listener: _resource_record_post_action 08:43:43 INFO - ##### 08:43:43 INFO - ##### Running run-tests step. 08:43:43 INFO - ##### 08:43:43 INFO - Running pre-action listener: _resource_record_pre_action 08:43:43 INFO - Running main action method: run_tests 08:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:43 INFO - Python 2.7.3 08:43:43 INFO - Return code: 0 08:43:43 INFO - grabbing minidump binary from tooltool 08:43:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:43 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/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 0x2156100>, '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 0x2157000>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2157490>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:43:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:43:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:43 INFO - Return code: 0 08:43:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:43:44 INFO - Return code: 0 08:43:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:43:44 INFO - Using env: {'DISPLAY': ':0', 08:43:44 INFO - 'HOME': '/home/cltbld', 08:43:44 INFO - 'LANG': 'en_US.UTF-8', 08:43:44 INFO - 'LANGUAGE': 'en_US:en', 08:43:44 INFO - 'LOGNAME': 'cltbld', 08:43:44 INFO - 'MAIL': '/var/mail/cltbld', 08:43:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:44 INFO - 'MOZ_NO_REMOTE': '1', 08:43:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:44 INFO - 'NO_EM_RESTART': '1', 08:43:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:44 INFO - 'PWD': '/builds/slave/test', 08:43:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:44 INFO - 'SHELL': '/bin/bash', 08:43:44 INFO - 'SHLVL': '1', 08:43:44 INFO - 'TERM': 'linux', 08:43:44 INFO - 'TMOUT': '86400', 08:43:44 INFO - 'USER': 'cltbld', 08:43:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031', 08:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:44 INFO - '_': '/tools/buildbot/bin/python'} 08:43:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:43:44 INFO - mozversion application_buildid: 20160211071132 08:43:44 INFO - mozversion application_changeset: fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e 08:43:44 INFO - mozversion application_display_name: Nightly 08:43:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:44 INFO - mozversion application_name: Firefox 08:43:44 INFO - mozversion application_remotingname: firefox 08:43:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:43:44 INFO - mozversion application_vendor: Mozilla 08:43:44 INFO - mozversion application_version: 47.0a1 08:43:44 INFO - mozversion platform_buildid: 20160211071132 08:43:44 INFO - mozversion platform_changeset: fe8b8550ff4b0a6aada0a67dd65979f8668c7e0e 08:43:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:43:44 INFO - mozversion platform_version: 47.0a1 08:43:44 INFO - using testdate: 1455209024 08:43:44 INFO - actual date: 1455209024 08:43:44 INFO - starting webserver on 'localhost:43501' 08:43:44 INFO - SUITE-START | Running 2 tests 08:43:44 INFO - TEST-START | dromaeo_css 08:43:44 INFO - operating with platform_type : linux_ 08:43:44 INFO - Initialising browser for dromaeo_css test... 08:43:44 INFO - TEST-INFO | started process 27022 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBplInT/profile http://localhost:43501/getInfo.html) 08:43:49 INFO - PROCESS | 27022 | __metrics Screen width/height:1600/1200 08:43:49 INFO - PROCESS | 27022 | colorDepth:24 08:43:49 INFO - PROCESS | 27022 | Browser inner width/height: 1024/697 08:43:49 INFO - PROCESS | 27022 | __metrics 08:43:49 INFO - PROCESS | 27022 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:50 INFO - TEST-INFO | 27022: exit 0 08:43:50 INFO - Browser initialized. 08:43:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:50 INFO - TEST-INFO | started process 27114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBplInT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:02 INFO - PROCESS | 27114 | RSS: Main: 153866240 08:44:02 INFO - PROCESS | 27114 | 08:44:53 INFO - PROCESS | 27114 | 1455209093308 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] 08:47:04 INFO - PROCESS | 27114 | Cycle 1(1): loaded http://localhost:43501/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43501/tests/dromaeo/cssquery-ext.html) 08:47:06 INFO - PROCESS | 27114 | RSS: Main: 238612480 08:47:06 INFO - PROCESS | 27114 | 08:50:08 INFO - PROCESS | 27114 | Cycle 1(1): loaded http://localhost:43501/tests/dromaeo/cssquery-ext.html (next: http://localhost:43501/tests/dromaeo/cssquery-jquery.html) 08:50:09 INFO - PROCESS | 27114 | RSS: Main: 232665088 08:50:09 INFO - PROCESS | 27114 | 08:53:11 INFO - PROCESS | 27114 | Cycle 1(1): loaded http://localhost:43501/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43501/tests/dromaeo/cssquery-mootools.html) 08:53:11 INFO - PROCESS | 27114 | RSS: Main: 239767552 08:53:11 INFO - PROCESS | 27114 | 08:56:13 INFO - PROCESS | 27114 | Cycle 1(1): loaded http://localhost:43501/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43501/tests/dromaeo/cssquery-prototype.html) 08:56:14 INFO - PROCESS | 27114 | RSS: Main: 221847552 08:56:14 INFO - PROCESS | 27114 | 08:59:17 INFO - PROCESS | 27114 | Cycle 1(1): loaded http://localhost:43501/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43501/tests/dromaeo/cssquery-yui.html) 08:59:17 INFO - PROCESS | 27114 | RSS: Main: 223072256 08:59:17 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | Cycle 1(1): loaded http://localhost:43501/tests/dromaeo/cssquery-yui.html (next: http://localhost:43501/tests/dromaeo/cssquery-dojo.html) 09:02:20 INFO - PROCESS | 27114 | RSS: Main: 266743808 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | __start_tp_report 09:02:20 INFO - PROCESS | 27114 | _x_x_mozilla_page_load 09:02:20 INFO - PROCESS | 27114 | _x_x_mozilla_page_load_details 09:02:20 INFO - PROCESS | 27114 | |i|pagename|runs| 09:02:20 INFO - PROCESS | 27114 | |0;dojo.html;2565.9486810263797;2653.880575374108;2655.8539280339573;2671.3989352395715;2679.665041869767;4408.845690400836;4477.753723545204;4558.316252562113;4565.680402371831;4572.382728331674;4474.888127796807;4498.370228168059;4575.725456472614;4634.930476042862;4645.37287466192;4173;4186.874393768192;4195.622393984533;4200.348945913388;4331.133773245348;4068.837246510136;4245.27830268855;4282.828686852522;4296.419983302246;4320.049589090411;4164.292070348048;4178.080822219107;4223.303154979425;4240.872773816791;4251.213525497793;4228.175505776375;4228.365745138223;4233.894152646178;4255.74465532066;4265.594768496988;4064.7967601619803;4213.599708027732;4230.048239146198;4232.217039847607;4252.319628859399;4459.152760975404;4505.459344878635;4562.908741825178;4592.380028696117;4622.791974361162;4847.83032593861;4848.248521479141;4851.927221091686;4864.683795553277;4890.290907818382;4652.767361631905;4742.19382704941;4870.853874383774;4887.169181239198;4920.680155789898;4454.710443821141;4513.255312873339;4526.434195725535;4530.864074077783;4570.040291538748;4984.501549844987;5002.399712034507;5010.2735103409805;5031.496850315012;5063.87340316495;4612.700174488715;4680.81276748933;4790.209615413418;4804.495527969582;4809.735464549483;4847.903041939141;4865.732384718804;4876.29293752411;4897.975510122426;4909.042736666316;4812.783424745895;4813.326134341195;4814.927776083362;4818.204996175592;4869.050535145683;4622.075584882969;4720.669553131248;4770.570648641639;4809.639277054235;4859.65982381237;4054.1486287879284;4075;4076.5311989121037;4085.162541678949;4087.652549533323;3587.497750314958;3590;3614.493970844084;3618.764780289273;3635.709143268532;3941.586133456003;4021.2158629067053;4066.8373265069067;4094.28350038742;4154.231467178582;4817.301491283744;4824.589909857701;4844.273358996179;4863.1732605457155;4893;3959.544652365015;4063.4108054332546;4082.2039702257775;4094.7952602369764;4107.732997355162;4213.536510983789;4253.298205796009;4257.212415703105;4261.8066941255875;4309.375140604595;4514.322851572159;4546.02260513991;4548.5224051474115;4583.839565615188;4599.241125214302;4718.669693121586;4793.664443488922;4799.184138696361;4804.975975120102;4812.230043193073;4534.229181039165;4572.337011133433;4581.908361832811;4615.169269531382;4626.676132670681;4780.95219047805;4813.446453657734;4818.566329030404;4818.590419814355;4881.8535443936735;4637.118947399983;4751.83368582098;4779.498152694056;4860.781264843161;4896.2410826321975;4613.561711637389;4633.166030114477;4650.48844627084;4675.812967481399;4685.67200295976;4629.444466664022;4635.23518619424;4644.442666879996;4652.790624421977;4698.647601429838;4441.067375850978;4490.191765482245;4531.682782205214;4565.56627120423;4596.678232523691;4685.344051832814;4689.437267527918;4705.176594095951;4714.882127946828;4759.214729569582;4598.931016034695;4610;4614.146382919171;4614.653900957374;4658.394408726844 09:02:20 INFO - PROCESS | 27114 | |1;ext.html;490.41640447867036;511.6929842094742;516.7080599461304;524.3655177235545;536.8469986053974;25292.74707252929;33442.66557334426;34203.82898085512;34217.48673769896;34316.31367372651;36704.63295367046;37733.811330943376;37979.430308545394;37995.430068548994;38044.429333560016;7624.123225829046;7803.8049048773955;7807.921920780805;7810.101838288584;7815.687372505093;7719.382449404062;7858.842823143534;7865.646045927947;7869.52782833029;7873.881891771628;7806.258405451473;8141.307988820958;8145.3076488498255;8148.348132149414;8151.836963260731;7906.367490600738;7960.243776841191;7972.720954766613;7975.082865470487;7983.081945576275;7800.882986755203;7932.127465978738;7940.761777146695;7942.722004729864;7948.443608947376;37735;38137.61862381396;38161;38308.425373619415;38645.613543864485;3061.0663747556987;3082.7996180248438;3149.354382351635;3167.2081979505124;3188.9157686386507;28105.236027677027;28374.858125709445;28960;29086.563701544495;29154.41691166186;3355.8489867955755;3366.9057556294056;3404.063882432326;3406.2165701888457;3460.8788692395647;218315;218438;219519;219634;219670.9999999984;47752.28371574429;56141.15788263179;56403.71798140983;56578;56589;41996.79001604972;59268;61347.38652613506;61463;61518.384816151265;13762.65593360154;14092.718145637029;14095.647608809657;14102.294885255696;14153.433862645585;9476.573554190078;10477.37135771856;10566;10644.840327395095;10786.46067696612;18699.439016829518;18868.43394698161;18878.150483228288;18887.622247554973;18921.067234578662;6794.626295553792;6992.860142797115;7043.049188359609;7044.119485064367;7045.365917067488;886.7871710789364;899.8335307968047;980.568549838069;983.2871168402994;1041.807265655856;26320.473590528083;26460.206193813832;26561.601575976376;26933.461330773276;26969.595456068175;980.9803803924025;992.2310209587628;1018.3533456255332;1023.6928921323573;1056.529844219315;14104.365303561159;14107.153570785786;14710.779338309934;14988.700225995637;14990.850091499164;246668;253230;253276;253778;253861;47222.52777472181;47606;47646.76176619164;47661.285080723814;47683;1226.7669142863006;1234.8209509621054;1237.4678888078033;1253.210477399251;1257.5221415862097;26420;27163.86418067976;27364.315892102855;27778.44443111086;27888.58167127454;36705;41530;42076;42117;42204.366934495396;160405.19797400938;160409;162295;162310;162348;26589.202323930313;26657.46685066249;26940.191794246202;26973.730262697907;27006.864965675046;38983.805080974416;39691.80154099211;39851.60148398479;39945.4649116286;40811.38782918199;32936.34127317392;33642.831785840914;36696.22949016718;36721;37061.44407833939;32764.83617581992;33143.502847456824;33218.66781332252;33296.833515832266;33385.49921751127;33234.83382583072;33546.66453335436;33561.664383355856;33913.66086339204;34109.317813644084;27688;28798.856005720674;30069.84965075248;30158;33088.338233235685;23372.532549349256;24025.27924162278;24723.381915451537;24833;25538.872305638353 09:02:20 INFO - PROCESS | 27114 | |2;jquery.html;334.6870675918017;338.6884066658673;339.08109024543484;341.73515525467775;349.57352030522753;11951.402429878493;12434.440450179742;14628;15012.549623511299;16083.919580402111;14003.929980350109;14424;14472;15140.848591514108;15211.619709507268;4621.37611422457;4896.926546101811;4952.727599981999;5027.667668067965;5175.5600773934075;3566.7324950628677;3733.7386382953205;5678.48893599576;5813.389594092623;5879.382664820197;5707.200991861143;5752.453516915886;5779.133130030508;5807.593468457209;5873.765049398019;5792.942070579283;5836.416358364151;5836.9124463133085;5838.2702162229725;5843.707814609295;4888.437829649601;5058.848234552969;5100.795968161269;5107.668001579886;5107.846764597031;17415.73876391855;17667.646647067115;18061.367852125113;18746.0626968651;18758.812411875842;1852.944411667652;1894.4695485264149;1916.9712454313196;2058.7323647925823;2345.414714233669;8090.595470226465;8463.195996380335;8895.510746908918;11583.18917675763;12708.491660333668;1775.6803775320436;1802.5133214032137;1804.846588040018;1808.5117018404958;1815.5733402650367;52319.47680523184;53147.20279195777;53621;54541.72729136329;54743.90512189734;9479.715608531755;9841.704748857546;9849.901500985041;9877.259205559612;9978.60085596568;12551.623451296477;12575.182613130117;12588.433520491417;12597.622071337875;12600.747985040249;7012.158540975013;7125.35871771543;7147.499675022698;7158.391536719437;7189.4967352285885;6717.731290748316;6733.158355205599;6736.730530778714;6846.349596788297;6859.622720750406;3739.1586892949413;3927.293087244266;4097.815598298083;4167.124903770182;4167.708260421741;1649.6370798424327;1703.8381353771372;1706.2748331958867;1727.585379508934;1742.2160027987456;391.14729888842027;396.4390387601569;397.44159455964416;798.6805277888891;872.7425409504211;8890.911090889009;9357.578908949114;9384.343095983215;9500.239980801658;9552.188064014497;410.2901979575292;410.7679161273871;413.08913844971767;413.36548398208606;844.5903736687701;8024.558649274346;8356.623951922178;8408.705695300636;8504.44721093127;8554.61504232311;309749;311164;314651;315290;464952;41458.999999999396;43536;57060.42939570634;60708;60787.39212607817;1000.1298869983016;1028.6502589119734;1046.9214808889212;1049.0925349572717;1051.0435503691604;13923.860761392662;14117.858821411655;14357.712845743235;14438;14497.92751036238;28531;29016.7098329014;29565.2608684776;31254;32200.35599288048;38470.80764596159;39051.21897561976;39293.803530982164;39382.40926386049;39633.80183099066;6241.469475094486;6583.769568065095;6650;6661.600303981582;6722.420231245555;3171.381580591855;6489.675516224075;6657.088122605426;7822.491538050009;9810.16613587853;8048.235417635316;8158.510489370657;8460.576971151295;8496.660133594834;8852.778680533038;2655.0972669292532;4994.700317980933;8513.82897361169;8683.82632347337;8817.955910220408;7271.527350722186;8148.103708592169;8149.307308878811;8166.673333066611;8400.621972011397;6462.547621666438;6505.284418714033;6555.65609050134;6564.212294524496;6584.4732421405215;6770.2891196425635;8332.333413326798;8513.404061715868;8518.872216916876;8572.742817715478 09:02:20 INFO - PROCESS | 27114 | |3;mootools.html;1239.863615002349;1364.7475217084836;1380.8757211850934;1485.3835658201847;1692.7630131781546;6188.412100850418;7065.540739851913;7186.96406517968;7200;7202.855942881146;7043.612601306926;7229.313215244557;7230.1323841139;7230.16853061898;7235.421166306696;1731.939382121626;1772.0430967277719;2019.474936516509;2120.014193400065;2149.8602590831624;2068.400163952452;2080.271904833304;2088.8955552222405;2090.8536402451837;2093.42430831521;2056.9588608227828;2070.4823794051485;2104.863183893042;2109.1879626343816;2112.091800525773;2061.2785525066106;2073.0463986566197;2080.864743791656;2084.1663334666177;2116.100657220675;2021.9494512637154;2035.8065983731522;2047.068583794385;2048.1909645690016;2048.8770673759623;7255.23819998903;7313.414926805843;7316.926830731678;7319.74380896666;7328.560286382781;4049.5140583130215;4142.275101857163;4143.875683729493;4145.2124096421885;4152.750834949913;2744.9039283625175;2746.917592472229;2822.675392329888;2854.4576530459144;2867.197184788242;830.7466222802043;840.2983957486078;842.8988521377413;874.9300055995569;880.5201165364828;8869.113088691143;8915.955420222923;8990.640374385017;9000.77498062547;9003.999999999935;3768.076821178774;3772.320982223226;3794.734368594172;3866.033491627093;3869.342211823997;7480.551166930001;7482.401407887356;7484.925150748423;7491.475596708287;7500.174980752113;4050.8784736457956;4066.4916885389325;4072.2466343726505;4074.8166332515107;4091.7340372876265;3770.1517158639635;3776.5656949451163;3787.5833658297565;3797.6582107610448;3804.087019115392;2780.8331500110057;3107.1300035989957;3141.54447605096;3198.984005080006;3199.1362332170183;950.4344914775697;964.5177411294353;968.4818622037176;973.0123924216925;976.6435251133286;1168.684455197109;1174.4362705901215;1191.7616476704693;1192.3740036480744;1208.4078801387257;6840.0765896603325;6871.828204294832;6989.126359205099;6996.965015174993;7006.50954433195;1032.2877214721818;1033.9379637221791;1036.388530766836;1040.2146379483443;1044.6343779677052;5148;5211.088059589632;5232.529072383504;5261.053010458154;5261.053010458154;8190.385721070944;8403.873941890877;8772.78068048304;9067.927016926807;9091;8295.502269863828;8306.210909963544;8395.03457102429;8400.957995209985;8407.789805254917;6517.543771936013;6769.255381907986;6899.137607799025;6950.513464057467;6954.617496037666;6732.932670673231;6847.589144651337;6856.280090590616;6856.965715171392;6860.897086543806;7614.200508946481;7653.693852245848;7809.570473624005;7827.25641064098;7962.641681124479;7897.210278972057;7950.204979502004;7984.6406911687955;8006.479578827358;8152.755417337489;6641.269460359454;6727.93272067273;6728.05807187004;6740.73037078531;6750.25747167821;5830.941690583039;6547.312532184052;6634.402903738686;6680.832979175365;6684.63234522106;6297.590656607306;6340.365963403623;6382.393672601095;6424.196975378078;6443.6455994920725;6139.324674285915;6238.376162383725;6345.8730825384155;6394.584352017104;6413.743450262124;6189.35011823752;6258.687065646608;6259.812205633838;6270.843228919313;6277.811665650038;5915.615484993462;5974.342822289458;5994.82015539517;6053.818385448443;6062.939370606237;5933.199018132497;6106.511479081574;6148.938510614837;6185.567010309235;6194.946859033885 09:02:20 INFO - PROCESS | 27114 | |4;prototype.html;299.32950191570876;300.5296710647836;307.69538157224355;307.847615430362;312.4656836809056;5347.7326133693305;5390.326209223847;5401.3248343957;5434.402215756273;5438.401775804663;5043.016611760708;5202.92195617066;5208.374995000596;5216.556592689616;5348.786048558053;4055.4322394864594;4066.6949978751636;4176.331786914095;4186.832526698929;4195.517515485728;4178.477690288714;4191.664666826647;4192.056787222881;4192.140611174717;4199.286121359361;3884.864029758959;4010.4786377770847;4146.937795933063;4156.4181014657825;4160.875173744777;4116.423700681907;4123.876283711494;4127.9999999999845;4144.958550414487;4146.626803587661;3648.799316037617;3660.4875317455576;3660.560732712065;3665.083729067733;3672.265546890633;5106.719130447824;5110.156824124015;5113.463086375951;5114.181730923072;5134.332536770234;4655.301704744282;4752.144613969484;4755.976220118911;4765.761711914425;4767.666263361566;5579.13523403869;5582.190582365534;5585.525230355424;5585.8603534911545;5598.524125449342;3971.463852379921;3971.7815520146382;3975.363941769332;3975.662068724162;3978.602139785998;5864.794732184396;5868.383819698955;5872.941270587282;5875.735591898375;5887.646741195499;4015.297322968469;4097.119119389286;4102.2410853992105;4107.732997355162;4112.198121366305;4184.602462766033;4187.7696726679715;4188.434561334181;4194.266003449384;4210.578942105765;4739.028499157734;4744.857654270378;4746.644001699887;4746.881327966828;4750.857474275777;5589.357223919302;5589.608727389043;5595.272614560081;5596.664200148004;5596.944030559643;1439.3882599895003;1479.5857159995219;1480.1341215389118;1481.2593703148425;1481.3630139040101;1006.1498034161123;1006.2252065909355;1012.8227560177087;1030.6959446963165;1033.106362996018;4684.976575117103;4687.7656117194;4692.178868697964;4692.850251688358;4697.412823397075;5735.971320143372;5747.942520574741;5748.19525266463;5751.827445176651;5755.0791873300905;4675.7895894684825;4678.602318802872;4678.719276843401;4682.367880336179;4685.648576356787;2967.6587192473144;3023.5313526403443;3101.2712012677002;3102.8913988010313;3122.9063128106195;5474.890502189934;5492.038893193675;5493.423190565013;5500.037493438632;5507.669539827623;6019.367966363557;6022.759089636453;6023.126646636213;6030.48740857032;6033.547483938634;5368.946310536923;5484.2047903053835;5496.890062198813;5502.724863756796;5507.118860982224;5802.216700745345;5805.187273781589;5806.158107074535;5807.332156801853;5809.331926828299;5712.80005199816;5713.085906255145;5749.655020698771;5771.7979870706;5774.971125144515;5376.112941364631;5496.7526461308535;5498.010358135574;5503.394626591152;5506.531944784578;4132.710710250374;4133.937990930199;4135.834566617422;4135.937960930649;4142.068034692291;5793.971030144822;5797.333306669787;5804.21643078179;5806.68063256525;5810.738516766671;5530.723463826873;5537.473939975695;5538.556915446674;5540.501354877919;5543.916841247304;5390.460953904578;5521.917171242515;5533.280673512418;5538.030844602259;5543.805966791143;5381.408045115112;5409;5409.729513524229;5417.891642167056;5421.241026256248;5542.140968149944;5547.084731019498;5551.389347171888;5552.833904880021;5554.638948468337;5227.006868694936;5415.1877218415975;5423.728813559227;5426.755795989269;5427.5657947363325 09:02:20 INFO - PROCESS | 27114 | |5;yui.html;764.1288930619094;766.2567309709583;781.4256521456725;786.3984052200068;789.5302295134395;13017.153884997468;13247.403866825993;13254.602361929134;13263.336833158339;13281.933590332059;12729.490820367175;12816.743665126714;12820.358982050906;12828.102032857703;12828.615141545768;603.7313395538987;613.8618810767587;777.5257093173174;783.5807842804101;796.5778137587088;768.6886810841618;774.0401901641951;774.6785084190054;777.2072486064211;779.7621725373758;825.051191130202;829.5727700234385;829.929455996241;830.9086000539936;831.9251267385933;631.9968400157993;802.297989259398;820.8317294954579;821.7534739578102;823.2672921100226;603.7102190948369;606.6087373644019;608.1759216261945;608.4554323880103;609.8597322615823;11890.821637675443;11927.284362938164;11963.1625786195;11984.880151198464;11989.340586267752;10955.34267943918;11098.889011109866;11478.368689722061;11514.136439767051;11588.188826782129;9816.705498835046;9823.165030972375;9898.851517227247;9910.35582687123;10040.89959100407;3291.2759192977505;3291.308825146722;3298.620658624241;3359.428897087501;3440.587129544446;39308.213835723414;39627.40558891619;39638.20723585541;39721.60278397208;39824.40263396051;9736.367136136128;9766.951165244129;9852.310338276251;9868.111869931741;9884.456354900549;16043.679126417639;16196.514104576881;16200.67598648044;16217.35130594763;16258.349666013228;6442.710078046499;6508.349165083454;6591.439727623206;6601.3728695773825;6667.86664266712;3663.377225871608;3674.1549443628114;3679.0986208379118;3688.3545379559005;3704.870329538453;2754.4628797384316;2803.4953708332696;2803.71962803718;2805.312698388867;2805.733455321741;496.48861672477403;498.7257008645303;499.1041081259149;499.1340025056524;500.88980424306595;558.6955109465351;564.601955621286;564.9406812284733;576.6280748916926;595.056834916662;7620.3522700569965;7949.682012719542;8088.676452941934;8141.592920353959;8209.876851847228;498.96257780666593;531.6491115863512;572.8224250482364;624.7407325959766;637.1653134393958;3532.91167720809;3675.6691897729334;3732.6080761519647;3739.9252014959548;3785.6025117362833;48089;48622.27066594004;48682.26976595354;48738.75630621895;48941;47050;47102.76448617735;47120.29319560209;47455.52544474511;47570.28644570334;40340;41321.793391033454;41689.79155104205;42043.36934945978;42064.15871682549;8086.8786968194345;8256.793580160544;8332.750017499484;8337.541435221121;8662.133786621287;29874.551881721356;30207.69792302137;30891.845540772152;31070.067897963097;31091.222719432197;38252.6174738249;39076.413853791644;39166;39602.60397395989;39657.2068558633;10145.086942174945;10202.18382529381;10316.27786054999;10360.430176340373;10384.32501887375;11649.767004660029;11746.706332341419;11915.862302056708;11922.940385298018;11928.880711192776;10859.619913302997;11151.665450036511;11446.885531144582;11603;11662.12534059932;10048.899511004796;10690.89309106899;10791.190660700322;10999.395033272927;11128.332300061698;9939;10194.796104077728;10980.890191097988;11025.338479691245;11375.31748095117;8947.463152210888;9079.182873541413;9213.585388657393;9221;9508.904910950801;8892.15524525169;9259.305552083486;9300.39547429415;9304.30217733659;9506.287028472754 09:02:20 INFO - PROCESS | 27114 | __end_tp_report 09:02:20 INFO - PROCESS | 27114 | __start_cc_report 09:02:20 INFO - PROCESS | 27114 | _x_x_mozilla_cycle_collect,798 09:02:20 INFO - PROCESS | 27114 | __end_cc_report 09:02:20 INFO - PROCESS | 27114 | __startTimestamp1455210140861__endTimestamp 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | ------- Summary: start ------- 09:02:20 INFO - PROCESS | 27114 | Number of tests: 6 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | [#0] dojo.html Cycles:165 Average:4466.96 Median:4592.38 stddev:451.30 (9.8%) stddev-sans-first:427.34 09:02:20 INFO - PROCESS | 27114 | Values: 2565.9 2653.9 2655.9 2671.4 2679.7 4408.8 4477.8 4558.3 4565.7 4572.4 4474.9 4498.4 4575.7 4634.9 4645.4 4173.0 4186.9 4195.6 4200.3 4331.1 4068.8 4245.3 4282.8 4296.4 4320.0 4164.3 4178.1 4223.3 4240.9 4251.2 4228.2 4228.4 4233.9 4255.7 4265.6 4064.8 4213.6 4230.0 4232.2 4252.3 4459.2 4505.5 4562.9 4592.4 4622.8 4847.8 4848.2 4851.9 4864.7 4890.3 4652.8 4742.2 4870.9 4887.2 4920.7 4454.7 4513.3 4526.4 4530.9 4570.0 4984.5 5002.4 5010.3 5031.5 5063.9 4612.7 4680.8 4790.2 4804.5 4809.7 4847.9 4865.7 4876.3 4898.0 4909.0 4812.8 4813.3 4814.9 4818.2 4869.1 4622.1 4720.7 4770.6 4809.6 4859.7 4054.1 4075.0 4076.5 4085.2 4087.7 3587.5 3590.0 3614.5 3618.8 3635.7 3941.6 4021.2 4066.8 4094.3 4154.2 4817.3 4824.6 4844.3 4863.2 4893.0 3959.5 4063.4 4082.2 4094.8 4107.7 4213.5 4253.3 4257.2 4261.8 4309.4 4514.3 4546.0 4548.5 4583.8 4599.2 4718.7 4793.7 4799.2 4805.0 4812.2 4534.2 4572.3 4581.9 4615.2 4626.7 4781.0 4813.4 4818.6 4818.6 4881.9 4637.1 4751.8 4779.5 4860.8 4896.2 4613.6 4633.2 4650.5 4675.8 4685.7 4629.4 4635.2 4644.4 4652.8 4698.6 4441.1 4490.2 4531.7 4565.6 4596.7 4685.3 4689.4 4705.2 4714.9 4759.2 4598.9 4610.0 4614.1 4614.7 4658.4 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | [#1] ext.html Cycles:180 Average:37835.80 Median:18504.87 stddev:55736.82 (301.2%) stddev-sans-first:55822.64 09:02:20 INFO - PROCESS | 27114 | Values: 490.4 511.7 516.7 524.4 536.8 25292.7 33442.7 34203.8 34217.5 34316.3 36704.6 37733.8 37979.4 37995.4 38044.4 7624.1 7803.8 7807.9 7810.1 7815.7 7719.4 7858.8 7865.6 7869.5 7873.9 7806.3 8141.3 8145.3 8148.3 8151.8 7906.4 7960.2 7972.7 7975.1 7983.1 7800.9 7932.1 7940.8 7942.7 7948.4 37735.0 38137.6 38161.0 38308.4 38645.6 3061.1 3082.8 3149.4 3167.2 3188.9 28105.2 28374.9 28960.0 29086.6 29154.4 3355.8 3366.9 3404.1 3406.2 3460.9 218315.0 218438.0 219519.0 219634.0 219671.0 47752.3 56141.2 56403.7 56578.0 56589.0 41996.8 59268.0 61347.4 61463.0 61518.4 13762.7 14092.7 14095.6 14102.3 14153.4 9476.6 10477.4 10566.0 10644.8 10786.5 18699.4 18868.4 18878.2 18887.6 18921.1 6794.6 6992.9 7043.0 7044.1 7045.4 886.8 899.8 980.6 983.3 1041.8 26320.5 26460.2 26561.6 26933.5 26969.6 981.0 992.2 1018.4 1023.7 1056.5 14104.4 14107.2 14710.8 14988.7 14990.9 246668.0 253230.0 253276.0 253778.0 253861.0 47222.5 47606.0 47646.8 47661.3 47683.0 1226.8 1234.8 1237.5 1253.2 1257.5 26420.0 27163.9 27364.3 27778.4 27888.6 36705.0 41530.0 42076.0 42117.0 42204.4 160405.2 160409.0 162295.0 162310.0 162348.0 26589.2 26657.5 26940.2 26973.7 27006.9 38983.8 39691.8 39851.6 39945.5 40811.4 32936.3 33642.8 36696.2 36721.0 37061.4 32764.8 33143.5 33218.7 33296.8 33385.5 33234.8 33546.7 33561.7 33913.7 34109.3 27688.0 28798.9 30069.8 30158.0 33088.3 23372.5 24025.3 24723.4 24833.0 25538.9 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | [#2] jquery.html Cycles:180 Average:20376.88 Median:5043.26 stddev:57123.32 (1132.7%) stddev-sans-first:57263.74 09:02:20 INFO - PROCESS | 27114 | Values: 334.7 338.7 339.1 341.7 349.6 11951.4 12434.4 14628.0 15012.5 16083.9 14003.9 14424.0 14472.0 15140.8 15211.6 4621.4 4896.9 4952.7 5027.7 5175.6 3566.7 3733.7 5678.5 5813.4 5879.4 5707.2 5752.5 5779.1 5807.6 5873.8 5792.9 5836.4 5836.9 5838.3 5843.7 4888.4 5058.8 5100.8 5107.7 5107.8 17415.7 17667.6 18061.4 18746.1 18758.8 1852.9 1894.5 1917.0 2058.7 2345.4 8090.6 8463.2 8895.5 11583.2 12708.5 1775.7 1802.5 1804.8 1808.5 1815.6 52319.5 53147.2 53621.0 54541.7 54743.9 9479.7 9841.7 9849.9 9877.3 9978.6 12551.6 12575.2 12588.4 12597.6 12600.7 7012.2 7125.4 7147.5 7158.4 7189.5 6717.7 6733.2 6736.7 6846.3 6859.6 3739.2 3927.3 4097.8 4167.1 4167.7 1649.6 1703.8 1706.3 1727.6 1742.2 391.1 396.4 397.4 798.7 872.7 8890.9 9357.6 9384.3 9500.2 9552.2 410.3 410.8 413.1 413.4 844.6 8024.6 8356.6 8408.7 8504.4 8554.6 309749.0 311164.0 314651.0 315290.0 464952.0 41459.0 43536.0 57060.4 60708.0 60787.4 1000.1 1028.7 1046.9 1049.1 1051.0 13923.9 14117.9 14357.7 14438.0 14497.9 28531.0 29016.7 29565.3 31254.0 32200.4 38470.8 39051.2 39293.8 39382.4 39633.8 6241.5 6583.8 6650.0 6661.6 6722.4 3171.4 6489.7 6657.1 7822.5 9810.2 8048.2 8158.5 8460.6 8496.7 8852.8 2655.1 4994.7 8513.8 8683.8 8818.0 7271.5 8148.1 8149.3 8166.7 8400.6 6462.5 6505.3 6555.7 6564.2 6584.5 6770.3 8332.3 8513.4 8518.9 8572.7 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | [#3] mootools.html Cycles:180 Average:4950.94 Median:6259.25 stddev:2556.30 (40.8%) stddev-sans-first:2548.25 09:02:20 INFO - PROCESS | 27114 | Values: 1239.9 1364.7 1380.9 1485.4 1692.8 6188.4 7065.5 7187.0 7200.0 7202.9 7043.6 7229.3 7230.1 7230.2 7235.4 1731.9 1772.0 2019.5 2120.0 2149.9 2068.4 2080.3 2088.9 2090.9 2093.4 2057.0 2070.5 2104.9 2109.2 2112.1 2061.3 2073.0 2080.9 2084.2 2116.1 2021.9 2035.8 2047.1 2048.2 2048.9 7255.2 7313.4 7316.9 7319.7 7328.6 4049.5 4142.3 4143.9 4145.2 4152.8 2744.9 2746.9 2822.7 2854.5 2867.2 830.7 840.3 842.9 874.9 880.5 8869.1 8916.0 8990.6 9000.8 9004.0 3768.1 3772.3 3794.7 3866.0 3869.3 7480.6 7482.4 7484.9 7491.5 7500.2 4050.9 4066.5 4072.2 4074.8 4091.7 3770.2 3776.6 3787.6 3797.7 3804.1 2780.8 3107.1 3141.5 3199.0 3199.1 950.4 964.5 968.5 973.0 976.6 1168.7 1174.4 1191.8 1192.4 1208.4 6840.1 6871.8 6989.1 6997.0 7006.5 1032.3 1033.9 1036.4 1040.2 1044.6 5148.0 5211.1 5232.5 5261.1 5261.1 8190.4 8403.9 8772.8 9067.9 9091.0 8295.5 8306.2 8395.0 8401.0 8407.8 6517.5 6769.3 6899.1 6950.5 6954.6 6732.9 6847.6 6856.3 6857.0 6860.9 7614.2 7653.7 7809.6 7827.3 7962.6 7897.2 7950.2 7984.6 8006.5 8152.8 6641.3 6727.9 6728.1 6740.7 6750.3 5830.9 6547.3 6634.4 6680.8 6684.6 6297.6 6340.4 6382.4 6424.2 6443.6 6139.3 6238.4 6345.9 6394.6 6413.7 6189.4 6258.7 6259.8 6270.8 6277.8 5915.6 5974.3 5994.8 6053.8 6062.9 5933.2 6106.5 6148.9 6185.6 6194.9 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | [#4] prototype.html Cycles:180 Average:4639.67 Median:5168.63 stddev:1346.17 (26.0%) stddev-sans-first:1309.94 09:02:20 INFO - PROCESS | 27114 | Values: 299.3 300.5 307.7 307.8 312.5 5347.7 5390.3 5401.3 5434.4 5438.4 5043.0 5202.9 5208.4 5216.6 5348.8 4055.4 4066.7 4176.3 4186.8 4195.5 4178.5 4191.7 4192.1 4192.1 4199.3 3884.9 4010.5 4146.9 4156.4 4160.9 4116.4 4123.9 4128.0 4145.0 4146.6 3648.8 3660.5 3660.6 3665.1 3672.3 5106.7 5110.2 5113.5 5114.2 5134.3 4655.3 4752.1 4756.0 4765.8 4767.7 5579.1 5582.2 5585.5 5585.9 5598.5 3971.5 3971.8 3975.4 3975.7 3978.6 5864.8 5868.4 5872.9 5875.7 5887.6 4015.3 4097.1 4102.2 4107.7 4112.2 4184.6 4187.8 4188.4 4194.3 4210.6 4739.0 4744.9 4746.6 4746.9 4750.9 5589.4 5589.6 5595.3 5596.7 5596.9 1439.4 1479.6 1480.1 1481.3 1481.4 1006.1 1006.2 1012.8 1030.7 1033.1 4685.0 4687.8 4692.2 4692.9 4697.4 5736.0 5747.9 5748.2 5751.8 5755.1 4675.8 4678.6 4678.7 4682.4 4685.6 2967.7 3023.5 3101.3 3102.9 3122.9 5474.9 5492.0 5493.4 5500.0 5507.7 6019.4 6022.8 6023.1 6030.5 6033.5 5368.9 5484.2 5496.9 5502.7 5507.1 5802.2 5805.2 5806.2 5807.3 5809.3 5712.8 5713.1 5749.7 5771.8 5775.0 5376.1 5496.8 5498.0 5503.4 5506.5 4132.7 4133.9 4135.8 4135.9 4142.1 5794.0 5797.3 5804.2 5806.7 5810.7 5530.7 5537.5 5538.6 5540.5 5543.9 5390.5 5521.9 5533.3 5538.0 5543.8 5381.4 5409.0 5409.7 5417.9 5421.2 5542.1 5547.1 5551.4 5552.8 5554.6 5227.0 5415.2 5423.7 5426.8 5427.6 09:02:20 INFO - PROCESS | 27114 | 09:02:20 INFO - PROCESS | 27114 | [#5] yui.html Cycles:180 Average:12440.04 Median:47076.38 stddev:13840.00 (29.4%) stddev-sans-first:13851.05 09:02:20 INFO - PROCESS | 27114 | Values: 764.1 766.3 781.4 786.4 789.5 13017.2 13247.4 13254.6 13263.3 13281.9 12729.5 12816.7 12820.4 12828.1 12828.6 603.7 613.9 777.5 783.6 796.6 768.7 774.0 774.7 777.2 779.8 825.1 829.6 829.9 830.9 831.9 632.0 802.3 820.8 821.8 823.3 603.7 606.6 608.2 608.5 609.9 11890.8 11927.3 11963.2 11984.9 11989.3 10955.3 11098.9 11478.4 11514.1 11588.2 9816.7 9823.2 9898.9 9910.4 10040.9 3291.3 3291.3 3298.6 3359.4 3440.6 39308.2 39627.4 39638.2 39721.6 39824.4 9736.4 9767.0 9852.3 9868.1 9884.5 16043.7 16196.5 16200.7 16217.4 16258.3 6442.7 6508.3 6591.4 6601.4 6667.9 3663.4 3674.2 3679.1 3688.4 3704.9 2754.5 2803.5 2803.7 2805.3 2805.7 496.5 498.7 499.1 499.1 500.9 558.7 564.6 564.9 576.6 595.1 7620.4 7949.7 8088.7 8141.6 8209.9 499.0 531.6 572.8 624.7 637.2 3532.9 3675.7 3732.6 3739.9 3785.6 48089.0 48622.3 48682.3 48738.8 48941.0 47050.0 47102.8 47120.3 47455.5 47570.3 40340.0 41321.8 41689.8 42043.4 42064.2 8086.9 8256.8 8332.8 8337.5 8662.1 29874.6 30207.7 30891.8 31070.1 31091.2 38252.6 39076.4 39166.0 39602.6 39657.2 10145.1 10202.2 10316.3 10360.4 10384.3 11649.8 11746.7 11915.9 11922.9 11928.9 10859.6 11151.7 11446.9 11603.0 11662.1 10048.9 10690.9 10791.2 10999.4 11128.3 9939.0 10194.8 10980.9 11025.3 11375.3 8947.5 9079.2 9213.6 9221.0 9508.9 8892.2 9259.3 9300.4 9304.3 9506.3 09:02:20 INFO - PROCESS | 27114 | -------- Summary: end -------- 09:02:20 INFO - PROCESS | 27114 | 09:02:21 INFO - TEST-INFO | 27114: exit 0 09:02:21 INFO - TEST-OK | dromaeo_css | took 1117060ms 09:02:21 INFO - TEST-START | kraken 09:02:21 INFO - operating with platform_type : linux_ 09:02:21 INFO - Initialising browser for kraken test... 09:02:21 INFO - TEST-INFO | started process 27293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5oLVg/profile http://localhost:43501/getInfo.html) 09:02:26 INFO - PROCESS | 27293 | __metrics Screen width/height:1600/1200 09:02:26 INFO - PROCESS | 27293 | colorDepth:24 09:02:26 INFO - PROCESS | 27293 | Browser inner width/height: 1024/697 09:02:26 INFO - PROCESS | 27293 | __metrics 09:02:26 INFO - PROCESS | 27293 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:02:27 INFO - TEST-INFO | 27293: exit 0 09:02:27 INFO - Browser initialized. 09:02:27 INFO - Running cycle 1/1 for kraken test... 09:02:27 INFO - TEST-INFO | started process 27370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL5oLVg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:39 INFO - PROCESS | 27370 | RSS: Main: 152289280 09:02:39 INFO - PROCESS | 27370 | 09:02:41 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43501/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:42 INFO - PROCESS | 27370 | RSS: Main: 194990080 09:02:42 INFO - PROCESS | 27370 | 09:02:45 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43501/tests/kraken/driver.html?testName=audio-dft) 09:02:45 INFO - PROCESS | 27370 | RSS: Main: 184483840 09:02:45 INFO - PROCESS | 27370 | 09:02:48 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43501/tests/kraken/driver.html?testName=audio-fft) 09:02:49 INFO - PROCESS | 27370 | RSS: Main: 173178880 09:02:49 INFO - PROCESS | 27370 | 09:02:51 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43501/tests/kraken/driver.html?testName=audio-oscillator) 09:02:52 INFO - PROCESS | 27370 | RSS: Main: 172802048 09:02:52 INFO - PROCESS | 27370 | 09:02:54 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43501/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:55 INFO - PROCESS | 27370 | RSS: Main: 174772224 09:02:55 INFO - PROCESS | 27370 | 09:02:58 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43501/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:58 INFO - PROCESS | 27370 | RSS: Main: 175910912 09:02:58 INFO - PROCESS | 27370 | 09:03:02 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43501/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:02 INFO - PROCESS | 27370 | RSS: Main: 174907392 09:03:02 INFO - PROCESS | 27370 | 09:03:05 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43501/tests/kraken/driver.html?testName=json-parse-financial) 09:03:06 INFO - PROCESS | 27370 | RSS: Main: 173969408 09:03:06 INFO - PROCESS | 27370 | 09:03:07 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43501/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:08 INFO - PROCESS | 27370 | RSS: Main: 186662912 09:03:08 INFO - PROCESS | 27370 | 09:03:10 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:11 INFO - PROCESS | 27370 | RSS: Main: 184987648 09:03:11 INFO - PROCESS | 27370 | 09:03:13 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:13 INFO - PROCESS | 27370 | RSS: Main: 198463488 09:03:13 INFO - PROCESS | 27370 | 09:03:16 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:16 INFO - PROCESS | 27370 | RSS: Main: 200130560 09:03:16 INFO - PROCESS | 27370 | 09:03:19 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:20 INFO - PROCESS | 27370 | RSS: Main: 197447680 09:03:20 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | Cycle 1(1): loaded http://localhost:43501/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43501/tests/kraken/driver.html?testName=ai-astar) 09:03:22 INFO - PROCESS | 27370 | RSS: Main: 260218880 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | __start_tp_report 09:03:22 INFO - PROCESS | 27370 | _x_x_mozilla_page_load 09:03:22 INFO - PROCESS | 27370 | _x_x_mozilla_page_load_details 09:03:22 INFO - PROCESS | 27370 | |i|pagename|runs| 09:03:22 INFO - PROCESS | 27370 | |0;ai-astar;112;115;110;113;114;115;106;115;116;115 09:03:22 INFO - PROCESS | 27370 | |1;audio-beat-detection;154;139;160;167;134;153;156;138;178;134 09:03:22 INFO - PROCESS | 27370 | |2;audio-dft;164;162;160;162;161;160;163;162;163;164 09:03:22 INFO - PROCESS | 27370 | |3;audio-fft;73;74;114;98;74;75;74;112;94;75 09:03:22 INFO - PROCESS | 27370 | |4;audio-oscillator;98;97;137;97;97;98;135;97;98;136 09:03:22 INFO - PROCESS | 27370 | |5;imaging-gaussian-blur;119;115;115;115;115;116;114;115;115;115 09:03:22 INFO - PROCESS | 27370 | |6;imaging-darkroom;146;147;147;147;146;146;147;147;146;147 09:03:22 INFO - PROCESS | 27370 | |7;imaging-desaturate;96;96;96;95;96;96;95;96;96;95 09:03:22 INFO - PROCESS | 27370 | |8;json-parse-financial;70;67;69;67;68;68;66;76;64;65 09:03:22 INFO - PROCESS | 27370 | |9;json-stringify-tinderbox;69;69;69;70;70;70;69;69;70;69 09:03:22 INFO - PROCESS | 27370 | |10;stanford-crypto-aes;85;83;84;84;86;83;100;83;87;92 09:03:22 INFO - PROCESS | 27370 | |11;stanford-crypto-ccm;132;124;124;138;129;125;123;126;122;133 09:03:22 INFO - PROCESS | 27370 | |12;stanford-crypto-pbkdf2;160;138;157;155;149;140;150;150;168;155 09:03:22 INFO - PROCESS | 27370 | |13;stanford-crypto-sha256-iterative;74;71;71;73;71;73;73;71;71;71 09:03:22 INFO - PROCESS | 27370 | __end_tp_report 09:03:22 INFO - PROCESS | 27370 | __start_cc_report 09:03:22 INFO - PROCESS | 27370 | _x_x_mozilla_cycle_collect,1069 09:03:22 INFO - PROCESS | 27370 | __end_cc_report 09:03:22 INFO - PROCESS | 27370 | __startTimestamp1455210202350__endTimestamp 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | ------- Summary: start ------- 09:03:22 INFO - PROCESS | 27370 | Number of tests: 14 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#0] ai-astar Cycles:10 Average:113.10 Median:115.00 stddev:3.07 (2.7%) stddev-sans-first:3.23 09:03:22 INFO - PROCESS | 27370 | Values: 112.0 115.0 110.0 113.0 114.0 115.0 106.0 115.0 116.0 115.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#1] audio-beat-detection Cycles:10 Average:151.30 Median:155.00 stddev:14.89 (9.6%) stddev-sans-first:15.76 09:03:22 INFO - PROCESS | 27370 | Values: 154.0 139.0 160.0 167.0 134.0 153.0 156.0 138.0 178.0 134.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.45 (0.9%) stddev-sans-first:1.36 09:03:22 INFO - PROCESS | 27370 | Values: 164.0 162.0 160.0 162.0 161.0 160.0 163.0 162.0 163.0 164.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#3] audio-fft Cycles:10 Average:86.30 Median:74.50 stddev:16.70 (22.4%) stddev-sans-first:17.01 09:03:22 INFO - PROCESS | 27370 | Values: 73.0 74.0 114.0 98.0 74.0 75.0 74.0 112.0 94.0 75.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:97.00 stddev:18.64 (19.2%) stddev-sans-first:19.34 09:03:22 INFO - PROCESS | 27370 | Values: 98.0 97.0 137.0 97.0 97.0 98.0 135.0 97.0 98.0 136.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:1.35 (1.2%) stddev-sans-first:0.50 09:03:22 INFO - PROCESS | 27370 | Values: 119.0 115.0 115.0 115.0 115.0 116.0 114.0 115.0 115.0 115.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 09:03:22 INFO - PROCESS | 27370 | Values: 146.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 147.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:03:22 INFO - PROCESS | 27370 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#8] json-parse-financial Cycles:10 Average:68.00 Median:68.00 stddev:3.33 (4.9%) stddev-sans-first:3.46 09:03:22 INFO - PROCESS | 27370 | Values: 70.0 67.0 69.0 67.0 68.0 68.0 66.0 76.0 64.0 65.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.50 stddev:0.52 (0.7%) stddev-sans-first:0.53 09:03:22 INFO - PROCESS | 27370 | Values: 69.0 69.0 69.0 70.0 70.0 70.0 69.0 69.0 70.0 69.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:84.50 stddev:5.42 (6.4%) stddev-sans-first:5.71 09:03:22 INFO - PROCESS | 27370 | Values: 85.0 83.0 84.0 84.0 86.0 83.0 100.0 83.0 87.0 92.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:5.23 (4.1%) stddev-sans-first:5.30 09:03:22 INFO - PROCESS | 27370 | Values: 132.0 124.0 124.0 138.0 129.0 125.0 123.0 126.0 122.0 133.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.20 Median:155.00 stddev:8.94 (5.8%) stddev-sans-first:9.03 09:03:22 INFO - PROCESS | 27370 | Values: 160.0 138.0 157.0 155.0 149.0 140.0 150.0 150.0 168.0 155.0 09:03:22 INFO - PROCESS | 27370 | 09:03:22 INFO - PROCESS | 27370 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:72.00 stddev:1.20 (1.7%) stddev-sans-first:1.00 09:03:22 INFO - PROCESS | 27370 | Values: 74.0 71.0 71.0 73.0 71.0 73.0 73.0 71.0 71.0 71.0 09:03:22 INFO - PROCESS | 27370 | -------- Summary: end -------- 09:03:22 INFO - PROCESS | 27370 | 09:03:23 INFO - TEST-INFO | 27370: exit 0 09:03:23 INFO - TEST-OK | kraken | took 61739ms 09:03:23 INFO - SUITE-END | took 1178s 09:03:23 INFO - Completed test suite (00:19:38) 09:03:23 INFO - Working with test: dromaeo_css 09:03:23 INFO - Generating results file: dromaeo_css 09:03:23 INFO - Working with test: kraken 09:03:23 INFO - Generating results file: kraken 09:03:23 INFO - javascript benchmark 09:03:23 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:23 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:03:23 INFO - process_Request line: dromaeo_css 6105.78 graph.html#tests=[[72,132,35]] 09:03:23 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:03:23 INFO - process_Request line: kraken 1555.30 graph.html#tests=[[232,132,35]] 09:03:23 INFO - RETURN: dromaeo_css: 6105.78 09:03:23 INFO - RETURN: kraken: 1555.30 09:03:23 INFO - javascript benchmark 09:03:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2565.9486810263797, 2653.880575374108, 2655.8539280339573, 2671.3989352395715, 2679.665041869767, 4408.845690400836, 4477.753723545204, 4558.316252562113, 4565.680402371831, 4572.382728331674, 4474.888127796807, 4498.370228168059, 4575.725456472614, 4634.930476042862, 4645.37287466192, 4173.0, 4186.874393768192, 4195.622393984533, 4200.348945913388, 4331.133773245348, 4068.837246510136, 4245.27830268855, 4282.828686852522, 4296.419983302246, 4320.049589090411, 4164.292070348048, 4178.080822219107, 4223.303154979425, 4240.872773816791, 4251.213525497793, 4228.175505776375, 4228.365745138223, 4233.894152646178, 4255.74465532066, 4265.594768496988, 4064.7967601619803, 4213.599708027732, 4230.048239146198, 4232.217039847607, 4252.319628859399, 4459.152760975404, 4505.459344878635, 4562.908741825178, 4592.380028696117, 4622.791974361162, 4847.83032593861, 4848.248521479141, 4851.927221091686, 4864.683795553277, 4890.290907818382, 4652.767361631905, 4742.19382704941, 4870.853874383774, 4887.169181239198, 4920.680155789898, 4454.710443821141, 4513.255312873339, 4526.434195725535, 4530.864074077783, 4570.040291538748, 4984.501549844987, 5002.399712034507, 5010.2735103409805, 5031.496850315012, 5063.87340316495, 4612.700174488715, 4680.81276748933, 4790.209615413418, 4804.495527969582, 4809.735464549483, 4847.903041939141, 4865.732384718804, 4876.29293752411, 4897.975510122426, 4909.042736666316, 4812.783424745895, 4813.326134341195, 4814.927776083362, 4818.204996175592, 4869.050535145683, 4622.075584882969, 4720.669553131248, 4770.570648641639, 4809.639277054235, 4859.65982381237, 4054.1486287879284, 4075.0, 4076.5311989121037, 4085.162541678949, 4087.652549533323, 3587.497750314958, 3590.0, 3614.493970844084, 3618.764780289273, 3635.709143268532, 3941.586133456003, 4021.2158629067053, 4066.8373265069067, 4094.28350038742, 4154.231467178582, 4817.301491283744, 4824.589909857701, 4844.273358996179, 4863.1732605457155, 4893.0, 3959.544652365015, 4063.4108054332546, 4082.2039702257775, 4094.7952602369764, 4107.732997355162, 4213.536510983789, 4253.298205796009, 4257.212415703105, 4261.8066941255875, 4309.375140604595, 4514.322851572159, 4546.02260513991, 4548.5224051474115, 4583.839565615188, 4599.241125214302, 4718.669693121586, 4793.664443488922, 4799.184138696361, 4804.975975120102, 4812.230043193073, 4534.229181039165, 4572.337011133433, 4581.908361832811, 4615.169269531382, 4626.676132670681, 4780.95219047805, 4813.446453657734, 4818.566329030404, 4818.590419814355, 4881.8535443936735, 4637.118947399983, 4751.83368582098, 4779.498152694056, 4860.781264843161, 4896.2410826321975, 4613.561711637389, 4633.166030114477, 4650.48844627084, 4675.812967481399, 4685.67200295976, 4629.444466664022, 4635.23518619424, 4644.442666879996, 4652.790624421977, 4698.647601429838, 4441.067375850978, 4490.191765482245, 4531.682782205214, 4565.56627120423, 4596.678232523691, 4685.344051832814, 4689.437267527918, 4705.176594095951, 4714.882127946828, 4759.214729569582, 4598.931016034695, 4610.0, 4614.146382919171, 4614.653900957374, 4658.394408726844], "unit": "score", "name": "dojo.html", "value": 4439.991633858551}, {"lowerIsBetter": false, "replicates": [490.41640447867036, 511.6929842094742, 516.7080599461304, 524.3655177235545, 536.8469986053974, 25292.74707252929, 33442.66557334426, 34203.82898085512, 34217.48673769896, 34316.31367372651, 36704.63295367046, 37733.811330943376, 37979.430308545394, 37995.430068548994, 38044.429333560016, 7624.123225829046, 7803.8049048773955, 7807.921920780805, 7810.101838288584, 7815.687372505093, 7719.382449404062, 7858.842823143534, 7865.646045927947, 7869.52782833029, 7873.881891771628, 7806.258405451473, 8141.307988820958, 8145.3076488498255, 8148.348132149414, 8151.836963260731, 7906.367490600738, 7960.243776841191, 7972.720954766613, 7975.082865470487, 7983.081945576275, 7800.882986755203, 7932.127465978738, 7940.761777146695, 7942.722004729864, 7948.443608947376, 37735.0, 38137.61862381396, 38161.0, 38308.425373619415, 38645.613543864485, 3061.0663747556987, 3082.7996180248438, 3149.354382351635, 3167.2081979505124, 3188.9157686386507, 28105.236027677027, 28374.858125709445, 28960.0, 29086.563701544495, 29154.41691166186, 3355.8489867955755, 3366.9057556294056, 3404.063882432326, 3406.2165701888457, 3460.8788692395647, 218315.0, 218438.0, 219519.0, 219634.0, 219670.9999999984, 47752.28371574429, 56141.15788263179, 56403.71798140983, 56578.0, 56589.0, 41996.79001604972, 59268.0, 61347.38652613506, 61463.0, 61518.384816151265, 13762.65593360154, 14092.718145637029, 14095.647608809657, 14102.294885255696, 14153.433862645585, 9476.573554190078, 10477.37135771856, 10566.0, 10644.840327395095, 10786.46067696612, 18699.439016829518, 18868.43394698161, 18878.150483228288, 18887.622247554973, 18921.067234578662, 6794.626295553792, 6992.860142797115, 7043.049188359609, 7044.119485064367, 7045.365917067488, 886.7871710789364, 899.8335307968047, 980.568549838069, 983.2871168402994, 1041.807265655856, 26320.473590528083, 26460.206193813832, 26561.601575976376, 26933.461330773276, 26969.595456068175, 980.9803803924025, 992.2310209587628, 1018.3533456255332, 1023.6928921323573, 1056.529844219315, 14104.365303561159, 14107.153570785786, 14710.779338309934, 14988.700225995637, 14990.850091499164, 246668.0, 253230.0, 253276.0, 253778.0, 253861.0, 47222.52777472181, 47606.0, 47646.76176619164, 47661.285080723814, 47683.0, 1226.7669142863006, 1234.8209509621054, 1237.4678888078033, 1253.210477399251, 1257.5221415862097, 26420.0, 27163.86418067976, 27364.315892102855, 27778.44443111086, 27888.58167127454, 36705.0, 41530.0, 42076.0, 42117.0, 42204.366934495396, 160405.19797400938, 160409.0, 162295.0, 162310.0, 162348.0, 26589.202323930313, 26657.46685066249, 26940.191794246202, 26973.730262697907, 27006.864965675046, 38983.805080974416, 39691.80154099211, 39851.60148398479, 39945.4649116286, 40811.38782918199, 32936.34127317392, 33642.831785840914, 36696.22949016718, 36721.0, 37061.44407833939, 32764.83617581992, 33143.502847456824, 33218.66781332252, 33296.833515832266, 33385.49921751127, 33234.83382583072, 33546.66453335436, 33561.664383355856, 33913.66086339204, 34109.317813644084, 27688.0, 28798.856005720674, 30069.84965075248, 30158.0, 33088.338233235685, 23372.532549349256, 24025.27924162278, 24723.381915451537, 24833.0, 25538.872305638353], "unit": "score", "name": "ext.html", "value": 16656.10068127224}, {"lowerIsBetter": false, "replicates": [334.6870675918017, 338.6884066658673, 339.08109024543484, 341.73515525467775, 349.57352030522753, 11951.402429878493, 12434.440450179742, 14628.0, 15012.549623511299, 16083.919580402111, 14003.929980350109, 14424.0, 14472.0, 15140.848591514108, 15211.619709507268, 4621.37611422457, 4896.926546101811, 4952.727599981999, 5027.667668067965, 5175.5600773934075, 3566.7324950628677, 3733.7386382953205, 5678.48893599576, 5813.389594092623, 5879.382664820197, 5707.200991861143, 5752.453516915886, 5779.133130030508, 5807.593468457209, 5873.765049398019, 5792.942070579283, 5836.416358364151, 5836.9124463133085, 5838.2702162229725, 5843.707814609295, 4888.437829649601, 5058.848234552969, 5100.795968161269, 5107.668001579886, 5107.846764597031, 17415.73876391855, 17667.646647067115, 18061.367852125113, 18746.0626968651, 18758.812411875842, 1852.944411667652, 1894.4695485264149, 1916.9712454313196, 2058.7323647925823, 2345.414714233669, 8090.595470226465, 8463.195996380335, 8895.510746908918, 11583.18917675763, 12708.491660333668, 1775.6803775320436, 1802.5133214032137, 1804.846588040018, 1808.5117018404958, 1815.5733402650367, 52319.47680523184, 53147.20279195777, 53621.0, 54541.72729136329, 54743.90512189734, 9479.715608531755, 9841.704748857546, 9849.901500985041, 9877.259205559612, 9978.60085596568, 12551.623451296477, 12575.182613130117, 12588.433520491417, 12597.622071337875, 12600.747985040249, 7012.158540975013, 7125.35871771543, 7147.499675022698, 7158.391536719437, 7189.4967352285885, 6717.731290748316, 6733.158355205599, 6736.730530778714, 6846.349596788297, 6859.622720750406, 3739.1586892949413, 3927.293087244266, 4097.815598298083, 4167.124903770182, 4167.708260421741, 1649.6370798424327, 1703.8381353771372, 1706.2748331958867, 1727.585379508934, 1742.2160027987456, 391.14729888842027, 396.4390387601569, 397.44159455964416, 798.6805277888891, 872.7425409504211, 8890.911090889009, 9357.578908949114, 9384.343095983215, 9500.239980801658, 9552.188064014497, 410.2901979575292, 410.7679161273871, 413.08913844971767, 413.36548398208606, 844.5903736687701, 8024.558649274346, 8356.623951922178, 8408.705695300636, 8504.44721093127, 8554.61504232311, 309749.0, 311164.0, 314651.0, 315290.0, 464952.0, 41458.999999999396, 43536.0, 57060.42939570634, 60708.0, 60787.39212607817, 1000.1298869983016, 1028.6502589119734, 1046.9214808889212, 1049.0925349572717, 1051.0435503691604, 13923.860761392662, 14117.858821411655, 14357.712845743235, 14438.0, 14497.92751036238, 28531.0, 29016.7098329014, 29565.2608684776, 31254.0, 32200.35599288048, 38470.80764596159, 39051.21897561976, 39293.803530982164, 39382.40926386049, 39633.80183099066, 6241.469475094486, 6583.769568065095, 6650.0, 6661.600303981582, 6722.420231245555, 3171.381580591855, 6489.675516224075, 6657.088122605426, 7822.491538050009, 9810.16613587853, 8048.235417635316, 8158.510489370657, 8460.576971151295, 8496.660133594834, 8852.778680533038, 2655.0972669292532, 4994.700317980933, 8513.82897361169, 8683.82632347337, 8817.955910220408, 7271.527350722186, 8148.103708592169, 8149.307308878811, 8166.673333066611, 8400.621972011397, 6462.547621666438, 6505.284418714033, 6555.65609050134, 6564.212294524496, 6584.4732421405215, 6770.2891196425635, 8332.333413326798, 8513.404061715868, 8518.872216916876, 8572.742817715478], "unit": "score", "name": "jquery.html", "value": 7035.095368818449}, {"lowerIsBetter": false, "replicates": [1239.863615002349, 1364.7475217084836, 1380.8757211850934, 1485.3835658201847, 1692.7630131781546, 6188.412100850418, 7065.540739851913, 7186.96406517968, 7200.0, 7202.855942881146, 7043.612601306926, 7229.313215244557, 7230.1323841139, 7230.16853061898, 7235.421166306696, 1731.939382121626, 1772.0430967277719, 2019.474936516509, 2120.014193400065, 2149.8602590831624, 2068.400163952452, 2080.271904833304, 2088.8955552222405, 2090.8536402451837, 2093.42430831521, 2056.9588608227828, 2070.4823794051485, 2104.863183893042, 2109.1879626343816, 2112.091800525773, 2061.2785525066106, 2073.0463986566197, 2080.864743791656, 2084.1663334666177, 2116.100657220675, 2021.9494512637154, 2035.8065983731522, 2047.068583794385, 2048.1909645690016, 2048.8770673759623, 7255.23819998903, 7313.414926805843, 7316.926830731678, 7319.74380896666, 7328.560286382781, 4049.5140583130215, 4142.275101857163, 4143.875683729493, 4145.2124096421885, 4152.750834949913, 2744.9039283625175, 2746.917592472229, 2822.675392329888, 2854.4576530459144, 2867.197184788242, 830.7466222802043, 840.2983957486078, 842.8988521377413, 874.9300055995569, 880.5201165364828, 8869.113088691143, 8915.955420222923, 8990.640374385017, 9000.77498062547, 9003.999999999935, 3768.076821178774, 3772.320982223226, 3794.734368594172, 3866.033491627093, 3869.342211823997, 7480.551166930001, 7482.401407887356, 7484.925150748423, 7491.475596708287, 7500.174980752113, 4050.8784736457956, 4066.4916885389325, 4072.2466343726505, 4074.8166332515107, 4091.7340372876265, 3770.1517158639635, 3776.5656949451163, 3787.5833658297565, 3797.6582107610448, 3804.087019115392, 2780.8331500110057, 3107.1300035989957, 3141.54447605096, 3198.984005080006, 3199.1362332170183, 950.4344914775697, 964.5177411294353, 968.4818622037176, 973.0123924216925, 976.6435251133286, 1168.684455197109, 1174.4362705901215, 1191.7616476704693, 1192.3740036480744, 1208.4078801387257, 6840.0765896603325, 6871.828204294832, 6989.126359205099, 6996.965015174993, 7006.50954433195, 1032.2877214721818, 1033.9379637221791, 1036.388530766836, 1040.2146379483443, 1044.6343779677052, 5148.0, 5211.088059589632, 5232.529072383504, 5261.053010458154, 5261.053010458154, 8190.385721070944, 8403.873941890877, 8772.78068048304, 9067.927016926807, 9091.0, 8295.502269863828, 8306.210909963544, 8395.03457102429, 8400.957995209985, 8407.789805254917, 6517.543771936013, 6769.255381907986, 6899.137607799025, 6950.513464057467, 6954.617496037666, 6732.932670673231, 6847.589144651337, 6856.280090590616, 6856.965715171392, 6860.897086543806, 7614.200508946481, 7653.693852245848, 7809.570473624005, 7827.25641064098, 7962.641681124479, 7897.210278972057, 7950.204979502004, 7984.6406911687955, 8006.479578827358, 8152.755417337489, 6641.269460359454, 6727.93272067273, 6728.05807187004, 6740.73037078531, 6750.25747167821, 5830.941690583039, 6547.312532184052, 6634.402903738686, 6680.832979175365, 6684.63234522106, 6297.590656607306, 6340.365963403623, 6382.393672601095, 6424.196975378078, 6443.6455994920725, 6139.324674285915, 6238.376162383725, 6345.8730825384155, 6394.584352017104, 6413.743450262124, 6189.35011823752, 6258.687065646608, 6259.812205633838, 6270.843228919313, 6277.811665650038, 5915.615484993462, 5974.342822289458, 5994.82015539517, 6053.818385448443, 6062.939370606237, 5933.199018132497, 6106.511479081574, 6148.938510614837, 6185.567010309235, 6194.946859033885], "unit": "score", "name": "mootools.html", "value": 4064.348758792029}, {"lowerIsBetter": false, "replicates": [299.32950191570876, 300.5296710647836, 307.69538157224355, 307.847615430362, 312.4656836809056, 5347.7326133693305, 5390.326209223847, 5401.3248343957, 5434.402215756273, 5438.401775804663, 5043.016611760708, 5202.92195617066, 5208.374995000596, 5216.556592689616, 5348.786048558053, 4055.4322394864594, 4066.6949978751636, 4176.331786914095, 4186.832526698929, 4195.517515485728, 4178.477690288714, 4191.664666826647, 4192.056787222881, 4192.140611174717, 4199.286121359361, 3884.864029758959, 4010.4786377770847, 4146.937795933063, 4156.4181014657825, 4160.875173744777, 4116.423700681907, 4123.876283711494, 4127.9999999999845, 4144.958550414487, 4146.626803587661, 3648.799316037617, 3660.4875317455576, 3660.560732712065, 3665.083729067733, 3672.265546890633, 5106.719130447824, 5110.156824124015, 5113.463086375951, 5114.181730923072, 5134.332536770234, 4655.301704744282, 4752.144613969484, 4755.976220118911, 4765.761711914425, 4767.666263361566, 5579.13523403869, 5582.190582365534, 5585.525230355424, 5585.8603534911545, 5598.524125449342, 3971.463852379921, 3971.7815520146382, 3975.363941769332, 3975.662068724162, 3978.602139785998, 5864.794732184396, 5868.383819698955, 5872.941270587282, 5875.735591898375, 5887.646741195499, 4015.297322968469, 4097.119119389286, 4102.2410853992105, 4107.732997355162, 4112.198121366305, 4184.602462766033, 4187.7696726679715, 4188.434561334181, 4194.266003449384, 4210.578942105765, 4739.028499157734, 4744.857654270378, 4746.644001699887, 4746.881327966828, 4750.857474275777, 5589.357223919302, 5589.608727389043, 5595.272614560081, 5596.664200148004, 5596.944030559643, 1439.3882599895003, 1479.5857159995219, 1480.1341215389118, 1481.2593703148425, 1481.3630139040101, 1006.1498034161123, 1006.2252065909355, 1012.8227560177087, 1030.6959446963165, 1033.106362996018, 4684.976575117103, 4687.7656117194, 4692.178868697964, 4692.850251688358, 4697.412823397075, 5735.971320143372, 5747.942520574741, 5748.19525266463, 5751.827445176651, 5755.0791873300905, 4675.7895894684825, 4678.602318802872, 4678.719276843401, 4682.367880336179, 4685.648576356787, 2967.6587192473144, 3023.5313526403443, 3101.2712012677002, 3102.8913988010313, 3122.9063128106195, 5474.890502189934, 5492.038893193675, 5493.423190565013, 5500.037493438632, 5507.669539827623, 6019.367966363557, 6022.759089636453, 6023.126646636213, 6030.48740857032, 6033.547483938634, 5368.946310536923, 5484.2047903053835, 5496.890062198813, 5502.724863756796, 5507.118860982224, 5802.216700745345, 5805.187273781589, 5806.158107074535, 5807.332156801853, 5809.331926828299, 5712.80005199816, 5713.085906255145, 5749.655020698771, 5771.7979870706, 5774.971125144515, 5376.112941364631, 5496.7526461308535, 5498.010358135574, 5503.394626591152, 5506.531944784578, 4132.710710250374, 4133.937990930199, 4135.834566617422, 4135.937960930649, 4142.068034692291, 5793.971030144822, 5797.333306669787, 5804.21643078179, 5806.68063256525, 5810.738516766671, 5530.723463826873, 5537.473939975695, 5538.556915446674, 5540.501354877919, 5543.916841247304, 5390.460953904578, 5521.917171242515, 5533.280673512418, 5538.030844602259, 5543.805966791143, 5381.408045115112, 5409.0, 5409.729513524229, 5417.891642167056, 5421.241026256248, 5542.140968149944, 5547.084731019498, 5551.389347171888, 5552.833904880021, 5554.638948468337, 5227.006868694936, 5415.1877218415975, 5423.728813559227, 5426.755795989269, 5427.5657947363325], "unit": "score", "name": "prototype.html", "value": 4210.8092863069805}, {"lowerIsBetter": false, "replicates": [764.1288930619094, 766.2567309709583, 781.4256521456725, 786.3984052200068, 789.5302295134395, 13017.153884997468, 13247.403866825993, 13254.602361929134, 13263.336833158339, 13281.933590332059, 12729.490820367175, 12816.743665126714, 12820.358982050906, 12828.102032857703, 12828.615141545768, 603.7313395538987, 613.8618810767587, 777.5257093173174, 783.5807842804101, 796.5778137587088, 768.6886810841618, 774.0401901641951, 774.6785084190054, 777.2072486064211, 779.7621725373758, 825.051191130202, 829.5727700234385, 829.929455996241, 830.9086000539936, 831.9251267385933, 631.9968400157993, 802.297989259398, 820.8317294954579, 821.7534739578102, 823.2672921100226, 603.7102190948369, 606.6087373644019, 608.1759216261945, 608.4554323880103, 609.8597322615823, 11890.821637675443, 11927.284362938164, 11963.1625786195, 11984.880151198464, 11989.340586267752, 10955.34267943918, 11098.889011109866, 11478.368689722061, 11514.136439767051, 11588.188826782129, 9816.705498835046, 9823.165030972375, 9898.851517227247, 9910.35582687123, 10040.89959100407, 3291.2759192977505, 3291.308825146722, 3298.620658624241, 3359.428897087501, 3440.587129544446, 39308.213835723414, 39627.40558891619, 39638.20723585541, 39721.60278397208, 39824.40263396051, 9736.367136136128, 9766.951165244129, 9852.310338276251, 9868.111869931741, 9884.456354900549, 16043.679126417639, 16196.514104576881, 16200.67598648044, 16217.35130594763, 16258.349666013228, 6442.710078046499, 6508.349165083454, 6591.439727623206, 6601.3728695773825, 6667.86664266712, 3663.377225871608, 3674.1549443628114, 3679.0986208379118, 3688.3545379559005, 3704.870329538453, 2754.4628797384316, 2803.4953708332696, 2803.71962803718, 2805.312698388867, 2805.733455321741, 496.48861672477403, 498.7257008645303, 499.1041081259149, 499.1340025056524, 500.88980424306595, 558.6955109465351, 564.601955621286, 564.9406812284733, 576.6280748916926, 595.056834916662, 7620.3522700569965, 7949.682012719542, 8088.676452941934, 8141.592920353959, 8209.876851847228, 498.96257780666593, 531.6491115863512, 572.8224250482364, 624.7407325959766, 637.1653134393958, 3532.91167720809, 3675.6691897729334, 3732.6080761519647, 3739.9252014959548, 3785.6025117362833, 48089.0, 48622.27066594004, 48682.26976595354, 48738.75630621895, 48941.0, 47050.0, 47102.76448617735, 47120.29319560209, 47455.52544474511, 47570.28644570334, 40340.0, 41321.793391033454, 41689.79155104205, 42043.36934945978, 42064.15871682549, 8086.8786968194345, 8256.793580160544, 8332.750017499484, 8337.541435221121, 8662.133786621287, 29874.551881721356, 30207.69792302137, 30891.845540772152, 31070.067897963097, 31091.222719432197, 38252.6174738249, 39076.413853791644, 39166.0, 39602.60397395989, 39657.2068558633, 10145.086942174945, 10202.18382529381, 10316.27786054999, 10360.430176340373, 10384.32501887375, 11649.767004660029, 11746.706332341419, 11915.862302056708, 11922.940385298018, 11928.880711192776, 10859.619913302997, 11151.665450036511, 11446.885531144582, 11603.0, 11662.12534059932, 10048.899511004796, 10690.89309106899, 10791.190660700322, 10999.395033272927, 11128.332300061698, 9939.0, 10194.796104077728, 10980.890191097988, 11025.338479691245, 11375.31748095117, 8947.463152210888, 9079.182873541413, 9213.585388657393, 9221.0, 9508.904910950801, 8892.15524525169, 9259.305552083486, 9300.39547429415, 9304.30217733659, 9506.287028472754], "unit": "score", "name": "yui.html", "value": 5818.6535608708045}], "name": "dromaeo_css", "value": 6105.782518184035}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 110.0, 113.0, 114.0, 115.0, 106.0, 115.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [154.0, 139.0, 160.0, 167.0, 134.0, 153.0, 156.0, 138.0, 178.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 160.0, 162.0, 161.0, 160.0, 163.0, 162.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 114.0, 98.0, 74.0, 75.0, 74.0, 112.0, 94.0, 75.0], "unit": "score", "name": "audio-fft", "value": 86.3}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 137.0, 97.0, 97.0, 98.0, 135.0, 97.0, 98.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [119.0, 115.0, 115.0, 115.0, 115.0, 116.0, 114.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [70.0, 67.0, 69.0, 67.0, 68.0, 68.0, 66.0, 76.0, 64.0, 65.0], "unit": "score", "name": "json-parse-financial", "value": 68.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 84.0, 84.0, 86.0, 83.0, 100.0, 83.0, 87.0, 92.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [132.0, 124.0, 124.0, 138.0, 129.0, 125.0, 123.0, 126.0, 122.0, 133.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.6}, {"lowerIsBetter": true, "replicates": [160.0, 138.0, 157.0, 155.0, 149.0, 140.0, 150.0, 150.0, 168.0, 155.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.2}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 71.0, 73.0, 71.0, 73.0, 73.0, 71.0, 71.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1555.3000000000002}]} 09:03:23 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1555.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6105.78"}}} 09:03:23 INFO - Return code: 0 09:03:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:03:23 INFO - # TBPL SUCCESS # 09:03:23 INFO - Running post-action listener: _resource_record_post_action 09:03:23 INFO - Running post-run listener: _resource_record_post_run 09:03:24 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 393076736; Read time: 0; Write time: 301800 09:03:24 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 105332736; Read time: 0; Write time: 109432 09:03:24 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 287744000; Read time: 0; Write time: 192368 09:03:24 INFO - Running post-run listener: _upload_blobber_files 09:03:24 INFO - Blob upload gear active. 09:03:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:25 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:03:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:26 INFO - (blobuploader) - INFO - Done attempting. 09:03:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:03:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:03:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:26 INFO - (blobuploader) - INFO - Done attempting. 09:03:26 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:26 INFO - Return code: 0 09:03:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/17c99c81055b047ad87f42fcc4752831721730c564c41deb98e051eec747b23ca0a03a74c26e3ffc7c146ea05cb66ac22d289a02493b14ddcd34cea52ffd6647", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6ccdabc349b49429cd209dd6e46ea2c327d9e9af3096599ceefaa2fa7f515a9e98ec39fd60b05843b03751257dec9ea6439655b2359217f9ebec39d7bc8eeff"} 09:03:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:26 INFO - Contents: 09:03:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/17c99c81055b047ad87f42fcc4752831721730c564c41deb98e051eec747b23ca0a03a74c26e3ffc7c146ea05cb66ac22d289a02493b14ddcd34cea52ffd6647", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6ccdabc349b49429cd209dd6e46ea2c327d9e9af3096599ceefaa2fa7f515a9e98ec39fd60b05843b03751257dec9ea6439655b2359217f9ebec39d7bc8eeff"} 09:03:26 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:26 INFO - Copying logs to upload dir... 09:03:26 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.120844 ========= master_lag: 23.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-02-11 09:03:49.391923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 09:03:49.395366) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 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-Non-PGO/sha512/17c99c81055b047ad87f42fcc4752831721730c564c41deb98e051eec747b23ca0a03a74c26e3ffc7c146ea05cb66ac22d289a02493b14ddcd34cea52ffd6647", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6ccdabc349b49429cd209dd6e46ea2c327d9e9af3096599ceefaa2fa7f515a9e98ec39fd60b05843b03751257dec9ea6439655b2359217f9ebec39d7bc8eeff"} build_url:https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/Z9bipg3PRu6jvovBIV6VYw/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-Non-PGO/sha512/17c99c81055b047ad87f42fcc4752831721730c564c41deb98e051eec747b23ca0a03a74c26e3ffc7c146ea05cb66ac22d289a02493b14ddcd34cea52ffd6647", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f6ccdabc349b49429cd209dd6e46ea2c327d9e9af3096599ceefaa2fa7f515a9e98ec39fd60b05843b03751257dec9ea6439655b2359217f9ebec39d7bc8eeff"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-11 09:03:49.683468) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-02-11 09:03:49.683841) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1455208313.112909-1954841031 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 2.18 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2016-02-11 09:03:51.868767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 09:03:51.869092) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-11 09:03:52.008692) ========= ========= Total master_lag: 25.69 =========